Skip to Main Content

ORDS, SODA & JSON in the Database

Announcement

For appeals, questions and feedback about Oracle Forums, please email oracle-forums-moderators_us@oracle.com. Technical questions should be asked in the appropriate category. Thank you!

ORDS not logging errors on Tomcat

Olafur TOct 19 2020 — edited Oct 19 2020

Ok,
(Edit: This started out as a question, saved draft. Opened draft later and it only allowed me to continue with it as a discussion)
So for some reason, I can't figure out, ORDS stopped logging to the standard out (to the catalina* files)
I cant figure out why or how to turn it back on. I even scrapped the whole Tomcat setup, got the latest version (8.5.59) and deployed the ords.war file plus i directory. So this is in a fresh Tomcat + ORDS setup.
Only thing changed was in the server conf and that was changing the port from 8080 to 8000.
(ps. everything works, APEX is running, ORDS services work fine, I just need the error logging back)
defaults.conf has all switches related to logging and debug set to true.

<?xml version="1.0" encoding="UTF-8" standalone="no"?>
<!DOCTYPE properties SYSTEM "http://java.sun.com/dtd/properties.dtd">
<properties>
<comment>Saved on Fri Jul 17 14:35:18 GMT 2020</comment>
<entry key="cache.caching">false</entry>
<entry key="cache.directory">/tmp/apex/cache</entry>
<entry key="cache.duration">days</entry>
<entry key="cache.expiration">7</entry>
<entry key="cache.maxEntries">500</entry>
<entry key="cache.monitorInterval">60</entry>
<entry key="cache.procedureNameList"/>
<entry key="cache.type">lru</entry>
<entry key="database.api.enabled">true</entry>
<entry key="db.hostname">*removed*</entry>
<entry key="db.port">1521</entry>
<entry key="db.servicename">*removed*</entry>
<entry key="debug.debugger">true</entry>
<entry key="debug.printDebugToScreen">true</entry>
<entry key="error.keepErrorMessages">true</entry>
<entry key="error.maxEntries">50</entry>
<entry key="feature.sdw">true</entry>
<entry key="jdbc.DriverType">thin</entry>
<entry key="jdbc.InactivityTimeout">1800</entry>
<entry key="jdbc.InitialLimit">20</entry>
<entry key="jdbc.MaxConnectionReuseCount">10000</entry>
<entry key="jdbc.MaxLimit">1000</entry>
<entry key="jdbc.MaxStatementsLimit">1000</entry>
<entry key="jdbc.MinLimit">5</entry>
<entry key="jdbc.statementTimeout">900</entry>
<entry key="log.logging">true</entry>
<entry key="log.maxEntries">50</entry>
<entry key="misc.compress"/>
<entry key="misc.defaultPage">apex</entry>
<entry key="restEnabledSql.active">true</entry>
<entry key="security.crypto.enc.password">*removed*</entry>
<entry key="security.crypto.mac.password">*removed*</entry>
<entry key="security.disableDefaultExclusionList">false</entry>
<entry key="security.maxEntries">2000</entry>
<entry key="security.requestValidationFunction">wwv_flow_epg_include_modules.authorize</entry>
<entry key="security.validationFunctionType">plsql</entry>
<entry key="security.verifySSL">false</entry>
</properties>

I created a test handler just to produce an error to test

  ORDS.DEFINE_MODULE(
      p_module_name    => '123 Test',
      p_base_path      => '/testme/',
      p_items_per_page => 25,
      p_status         => 'PUBLISHED',
      p_comments       => NULL);


  ORDS.DEFINE_TEMPLATE(
      p_module_name    => '123 Test',
      p_pattern        => 'testme',
      p_priority       => 0,
      p_etag_type      => 'HASH',
      p_etag_query     => NULL,
      p_comments       => NULL);


  ORDS.DEFINE_HANDLER(
      p_module_name    => '123 Test',
      p_pattern        => 'testme',
      p_method         => 'GET',
      p_source_type    => 'plsql/block',
      p_items_per_page => 0,
      p_mimes_allowed  => '',
      p_comments       => NULL,
      p_source         => 
'begin
raise_application_error(-20122,''Test error logging'');
end;');

Nothing is being written to the catalina logs.

 96 -rw-r----- 1 tomcat tomcat  94463 okt 19 13:44 catalina.out
 92 -rw-r----- 1 tomcat tomcat  93831 okt 19 13:44 catalina.2020-10-19.log
252 -rw-r----- 1 tomcat tomcat 254963 okt 19 17:14 localhost_access_log.2020-10-19.txt

Any ideas what this could be?

After startup this is what is written and then nothing more until next shutdown/startup.

INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name:   Apache Tomcat/8.5.59
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built:          Oct 6 2020 16:57:18 UTC
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 8.5.59.0
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name:               Linux
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version:            3.10.0-1127.19.1.el7.x86_64
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture:          amd64
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home:             /usr/java/jdk1.8.0_251-amd64/jre
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version:           1.8.0_251-b08
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor:            Oracle Corporation
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE:         /tomcat/tomcat8
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME:         /tomcat/tomcat8
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=/tomcat/tomcat8/conf/logging.properties
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dorg.apache.catalina.security.SecurityListener.UMASK=0027
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Xms512m
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Xmx8192m
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs=
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=/tomcat/tomcat8
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=/tomcat/tomcat8
INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=/tomcat/tomcat8/temp
INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent The Apache Tomcat Native library which allows using OpenSSL was not found on the java.library.path: [/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib]
INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8000"]
INFO [main] org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared selector for servlet write/read
INFO [main] org.apache.catalina.startup.Catalina.load Initialization processed in 393 ms
INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina]
INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet Engine: Apache Tomcat/8.5.59
INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [/tomcat/tomcat8/webapps/ords.war]
INFO [localhost-startStop-1] org.apache.jasper.servlet.TldScanner.scanJars At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application archive [/tomcat/tomcat8/webapps/ords.war] has finished in [17,065] ms
INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/tomcat/tomcat8/webapps/ROOT]
INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/tomcat/tomcat8/webapps/ROOT] has finished in [9] ms
INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deploying web application directory [/tomcat/tomcat8/webapps/i]
INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployDirectory Deployment of web application directory [/tomcat/tomcat8/webapps/i] has finished in [10] ms
INFO [main] org.apache.coyote.AbstractProtocol.start Starting ProtocolHandler ["http-nio-8000"]
INFO [main] org.apache.catalina.startup.Catalina.start Server startup in 17130 ms
INFO [http-nio-8000-exec-10] oracle.dbtools.rt.resource.templates.cache.MetadataCachesProvider.activate Enabling metadata cache
Comments
Post Details
Added on Oct 19 2020
3 comments
2,594 views