GeezerVison

I get the error message above regularly after two or three succesfull testings.
Then I have two or three unsuccesful tries with the Oracle Driver stucks, after that in the next try can be succesfull again.
There is no unpredictability if the driver stucks or not.
So we have

30-Apr-2019 15:20:52
30-Apr-2019 15:20:52 C:\Users\vmwareadmin\bamboo-agent-home\xml-data\build-dir\SWITEGIT-WT-JOB1>utplsql run UNITTEST/P6YkF-k4il83_0s@AGTEST -p=UNITTEST.UT_PKG_AUSW_HP_SCHAEDEN -f=UT_JUNIT_REPORTER -o=C:\Users\vmwareadmin\bamboo-agent-home\xml-data\build-dir\SWITEGIT-WT-JOB1\UNIT_TEST_AGTEST_30-04-2019.xml
30-Apr-2019 15:20:52 ###################### utPLSQL cli #######################
30-Apr-2019 15:20:52 # #
30-Apr-2019 15:20:52 # utPLSQL-cli 3.1.6.local #
30-Apr-2019 15:20:52 # utPLSQL-java-api 3.1.6.411 #
30-Apr-2019 15:20:52 # Java-Version: 1.8.0_201 #
30-Apr-2019 15:20:52 # ORACLE_HOME: C:\oracle\product\12.2.0\client_1_x64 #
30-Apr-2019 15:20:52 # NLS_LANG: null #
30-Apr-2019 15:20:52 # #
30-Apr-2019 15:20:52 # Thanks for testing! #
30-Apr-2019 15:20:52 # #
30-Apr-2019 15:20:52 ##########################################################
30-Apr-2019 15:20:52
30-Apr-2019 15:20:53 HikariPool-1 - Driver does not support get/set network timeout for connections. (Nicht unterstützte Funktion: getNetworkTimeout)
30-Apr-2019 15:20:53 Use connection string jdbc:oracle:oci8:/@AGTest
30-Apr-2019 15:20:53 Successfully connected to database. UtPLSQL core: v3.1.2.2134
30-Apr-2019 15:20:53 Oracle-Version: 12.2.0.1.0
30-Apr-2019 15:20:53 Running tests now.
30-Apr-2019 15:20:53 --------------------------------------
30-Apr-2019 15:20:53 TestRunner initialized
30-Apr-2019 15:20:53 Running on utPLSQL v3.1.2.2134
30-Apr-2019 15:20:53 Initializing reporters
30-Apr-2019 15:20:55 Detected Oracle driver stuck during Statement initialization

I tried to experiment with different Clients and Java Versions but as it is said here in the other issues, there is not much scope for experiments while we have to use
Oracle Client 12.2 with jdbc 8 for the 3.1.6 Version of the utPLSQL-cli.
Since it's actually working and it's also the correct configuration I wonder what I can do to become more stability in the testings.
Perhaps I can send you a debug file of a failed test or you can suggest some better working versions of the ojdbc8.jar or the orai18n.jar ( both from 22.02.2019 ) ?

Greetings from Hannover, Germany !

Reacted by John

Activity

pesse commented on Apr 30, 2019
pesse
on Apr 30, 2019
Member
More actions
Hi @DrErique

what happens after the Detected Oracle driver stuck during Statement initialization?
The expected behavior would be that CLI does an automatic retry (and potentially some error stacks are written). Does this happen?
It's a problem we investigate since several months now and our solution (because it is very likely to be a driver bug) was to have an internal watchdog which detects such stuck scenario and does up to 5 retries. In that case the outcome of your tests wouldn't be changed, the only thing that happens is that the previous connection is abandoned and a second one is started.

Also: what would be your expectation how CLI deals with such a scenario?

Cheers,
Samuel

P.S. If you happen to be at ApexConnect in Bonn next week, make sure to say hello :)
DrErique commented on Apr 30, 2019
DrErique
on Apr 30, 2019 via email
Author
More actions
Hello Samuel, Thanks for the quick response. As you probably have noticed the utPLSQL Command starts from a Bamboo – Powershell – Skript – Task. I do not notice any retry . Last entry in the Log is "Detected Oracle Driver stuck …" and the build runs endless until it is stopped manually. As you can see in the picture the build ran for 21 minutes. Maybe I have to set some special parameters for the retries ? As you already found out retrying the connection for 1 – n times is the only thing you can offer in such cases. But in my case ist seems there is nor real retrying happening …. [cid:[email protected]] Mit freundlichen Grüßen Derik Wehrmann
…

_________________________________________________________________ Tel: -551 | Test- und Qualitätsmanager | IT SCM und Support Von: Samuel Nitsche <[email protected]> Gesendet: Dienstag, 30. April 2019 16:04 An: utPLSQL/utPLSQL-cli <[email protected]> Cc: Wehrmann, Derik <[email protected]>; Mention <[email protected]> Betreff: Re: [utPLSQL/utPLSQL-cli] Detected Oracle Driver stuck during Statement initialization (#145) Hi @DrErique<https://github.com/DrErique> what happens after the Detected Oracle driver stuck during Statement initialization? The expected behavior would be that CLI does an automatic retry (and potentially some error stacks are written). Does this happen? It's a problem we investigate since several months now and our solution (because it is very likely to be a driver bug) was to have an internal watchdog which detects such stuck scenario and does up to 5 retries. In that case the outcome of your tests wouldn't be changed, the only thing that happens is that the previous connection is abandoned and a second one is started. Also: what would be your expectation how CLI deals with such a scenario? Cheers, Samuel P.S. If you happen to be at ApexConnect in Bonn next week, make sure to say hello :) — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub<#145 (comment)>, or mute the thread<https://github.com/notifications/unsubscribe-auth/AIPTY43SEIDGFHTFQWDVQA3PTBGWPANCNFSM4HJLZYZA>.
pesse commented on May 3, 2019
pesse
on May 3, 2019
Member
More actions
Hm, this is strange - the Stuck is detected but it's not aborted (for whatever reason).
Can you try a different OJDBC driver?
I use ojdbc8-12.2.0.1.jar currently.
DrErique commented on May 3, 2019
DrErique
on May 3, 2019 via email
Author
More actions
Hello Samuel, I'll get that one and we see if this works better next week. Have a nice weekend ! Mit freundlichen Grüßen Derik Wehrmann
…

_________________________________________________________________ Tel: -551 | Test- und Releasemanager | IT SCM Von: Samuel Nitsche <[email protected]> Gesendet: Freitag, 3. Mai 2019 10:55 An: utPLSQL/utPLSQL-cli <[email protected]> Cc: Wehrmann, Derik <[email protected]>; Mention <[email protected]> Betreff: Re: [utPLSQL/utPLSQL-cli] Detected Oracle Driver stuck during Statement initialization (#145) Hm, this is strange - the Stuck is detected but it's not aborted (for whatever reason). Can you try a different OJDBC driver? I use ojdbc8-12.2.0.1.jar currently. — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub<#145 (comment)>, or mute the thread<https://github.com/notifications/unsubscribe-auth/AIPTY44UZUODUCVDHWFEV4TPTP4UPANCNFSM4HJLZYZA>.
DrErique commented on May 8, 2019
DrErique
on May 8, 2019
Author
More actions
Hello Samuel,

Unfortunately that didn't solve the problem.
Do we have any debug option ?

You mentioned the –d Parameter in another issue ?

What about this "HikariPool-1 - Driver does not support get/set network timeout for connections. " report. Perhaps we have a problem with the HikariCP ?
pesse commented on May 9, 2019
pesse
on May 9, 2019
Member
More actions
Yeah, this line is strange - didn't notice it so far in any of my runs.
Did you use the latest version of cli from the github page? (yes, there's still something wrong with putting the build number into the version automatically)
DrErique commented on May 9, 2019
DrErique
on May 9, 2019 via email
Author
More actions
I'll try that also, downloading latest version. We see if this works better … ☺ Von: Samuel Nitsche <[email protected]> Gesendet: Donnerstag, 9. Mai 2019 09:24 An: utPLSQL/utPLSQL-cli <[email protected]> Cc: Wehrmann, Derik <[email protected]>; Mention <[email protected]> Betreff: Re: [utPLSQL/utPLSQL-cli] Detected Oracle Driver stuck during Statement initialization (#145) Yeah, this line is strange - didn't notice it so far in any of my runs. Did you use the latest version of cli from the github page? (yes, there's still something wrong with putting the build number into the version automatically) — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub<#145 (comment)>, or mute the thread<https://github.com/notifications/unsubscribe-auth/AIPTY426DNC4Z4JRGNBDL4TPUPGQ5ANCNFSM4HJLZYZA>.

dmpe commented on May 10, 2019

dmpe

on May 10, 2019

Contributor

More actions

Hi,
I am also facing same issue here with Oracle DB 11.2,Java-Version: 1.8.0_212 , latest utPLSQL-cli 3.1.6 and jdbc 6 (the one from oracle site)

Actually I wanted to file a request for allowing to specifying more HikariConfig options, i.e. addDataSourceProperty (e.g. allowPoolSuspension)...maybe it would help slightly to debug the problem ("enterprise configurations")

I should also add that utPLSQL 3.1.2 was working well (as expected) - Hikari update ....

2019-05-10 11:03:22 [main] INFO  com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Starting...
2019-05-10 11:03:22 [main] DEBUG c.z.hikari.util.DriverDataSource - Loaded driver with class name oracle.jdbc.OracleDriver for jdbcUrl=jdbc:oracle:thin:xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
2019-05-10 11:03:23 [main] INFO  com.zaxxer.hikari.pool.PoolBase - HikariPool-1 - Driver does not support get/set network timeout for connections. (oracle.jdbc.driver.T4CConnection.getNetworkTimeout()I)
2019-05-10 11:03:23 [main] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection oracle.jdbc.driver.T4CConnection@2d928643
2019-05-10 11:03:23 [main] INFO  com.zaxxer.hikari.HikariDataSource - HikariPool-1 - Start completed.
2019-05-10 11:03:23 [main] INFO  o.u.c.d.TestedDataSourceProvider - Use connection string jdbc:oracle:thin:****/****@//xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
2019-05-10 11:03:23 [HikariPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=1, active=1, idle=0, waiting=0)
2019-05-10 11:03:23 [main] INFO  org.utplsql.cli.RunCommand - Successfully connected to database. UtPLSQL core: v3.1.1.1868
2019-05-10 11:03:23 [main] INFO  org.utplsql.cli.RunCommand - Oracle-Version: 11.2.0.4.0
2019-05-10 11:03:23 [main] DEBUG c.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection oracle.jdbc.driver.T4CConnection@2d928643 due to dirty commit state on close().
2019-05-10 11:03:23 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_COVERAGE_HTML_REPORTER, ID: 8885D6BC54DF5E4BE05311C8130A76B7
2019-05-10 11:03:23 [HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection oracle.jdbc.driver.T4CConnection@483c7db7
2019-05-10 11:03:23 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_DOCUMENTATION_REPORTER, ID: 8885D6BC54E35E4BE05311C8130A76B7
2019-05-10 11:03:23 [HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection oracle.jdbc.driver.T4CConnection@46fb8ac0
2019-05-10 11:03:23 [HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Added connection oracle.jdbc.driver.T4CConnection@42c416c7
2019-05-10 11:03:23 [HikariPool-1 connection adder] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - After adding stats (total=4, active=0, idle=4, waiting=0)
2019-05-10 11:03:25 [pool-1-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - Running tests now.
2019-05-10 11:03:25 [pool-1-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - --------------------------------------
2019-05-10 11:03:25 [pool-1-thread-1] INFO  org.utplsql.api.TestRunner - TestRunner initialized
2019-05-10 11:03:25 [pool-1-thread-1] INFO  org.utplsql.api.TestRunner - Running on utPLSQL v3.1.1.1868
2019-05-10 11:03:25 [pool-1-thread-1] INFO  org.utplsql.api.TestRunner - Initializing reporters
2019-05-10 11:03:27 [pool-1-thread-1] ERROR org.utplsql.api.TestRunner - Detected Oracle driver stuck during Statement initialization
2019-05-10 11:03:31 [pool-1-thread-1] DEBUG c.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Executed rollback on connection oracle.jdbc.driver.T4CConnection@2d928643 due to dirty commit state on close().
2019-05-10 11:03:53 [HikariPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=4, active=2, idle=2, waiting=0)
2019-05-10 11:04:23 [HikariPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=4, active=2, idle=2, waiting=0)
2019-05-10 11:04:53 [HikariPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=4, active=2, idle=2, waiting=0)
2019-05-10 11:05:23 [HikariPool-1 housekeeper] DEBUG com.zaxxer.hikari.pool.HikariPool - HikariPool-1 - Pool stats (total=4, active=2, idle=2, waiting=0)

EDIT: so using jdbc8 --the one for 12c on the database 11.2; instead of jdbc6 for 11.2), error has changed to .... This is also retried 4 times. I wonder if it has really something to do with Hikari, e.g brettwooldridge/HikariCP#198

2019-05-10 12:51:32 [pool-1-thread-1] ERROR org.utplsql.api.TestRunner - Detected Oracle driver stuck during Statement initialization
2019-05-10 12:51:32 [pool-2-thread-1] WARN  c.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - **Connection oracle.jdbc.driver.T4CConnection@3b088d51 marked as broken because of SQLSTATE(08006)**, ErrorCode(17002)
java.sql.SQLRecoverableException: IO Error: Socket read interrupted
	at oracle.jdbc.driver.T4CCallableStatement.executeForRows(T4CCallableStatement.java:929)
	at oracle.jdbc.driver.OracleStatement.doExecuteWithTimeout(OracleStatement.java:1119)
	at oracle.jdbc.driver.OraclePreparedStatement.executeInternal(OraclePreparedStatement.java:3780)
	at oracle.jdbc.driver.T4CCallableStatement.executeInternal(T4CCallableStatement.java:1300)
	at oracle.jdbc.driver.OraclePreparedStatement.execute(OraclePreparedStatement.java:3887)
	at oracle.jdbc.driver.OracleCallableStatement.execute(OracleCallableStatement.java:4230)
	at oracle.jdbc.driver.OraclePreparedStatementWrapper.execute(OraclePreparedStatementWrapper.java:1079)
	at com.zaxxer.hikari.pool.ProxyPreparedStatement.execute(ProxyPreparedStatement.java:44)
	at com.zaxxer.hikari.pool.HikariProxyCallableStatement.execute(HikariProxyCallableStatement.java)
	at org.utplsql.api.FileMapper.buildFileMappingArray(FileMapper.java:84)
	at org.utplsql.api.FileMapper.buildFileMappingList(FileMapper.java:90)
	at org.utplsql.api.testRunner.AbstractTestRunnerStatement.createStatement(AbstractTestRunnerStatement.java:60)
	at org.utplsql.api.testRunner.AbstractTestRunnerStatement.<init>(AbstractTestRunnerStatement.java:33)
	at org.utplsql.api.testRunner.Pre312TestRunnerStatement.<init>(Pre312TestRunnerStatement.java:17)
	at org.utplsql.api.testRunner.TestRunnerStatementProvider.getCompatibleTestRunnerStatement(TestRunnerStatementProvider.java:37)
	at org.utplsql.api.compatibility.CompatibilityProxy.getTestRunnerStatement(CompatibilityProxy.java:157)
	at org.utplsql.api.TestRunner.lambda$initStatementWithTimeout$0(TestRunner.java:199)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
Caused by: java.net.SocketTimeoutException: Socket read interrupted
	at oracle.net.nt.TimeoutSocketChannel.read(TimeoutSocketChannel.java:152)
	at oracle.net.ns.NIOHeader.readHeaderBuffer(NIOHeader.java:82)
	at oracle.net.ns.NIOPacket.readFromSocketChannel(NIOPacket.java:139)
	at oracle.net.ns.NIOPacket.readFromSocketChannel(NIOPacket.java:101)
	at oracle.net.ns.NIONSDataChannel.readDataFromSocketChannel(NIONSDataChannel.java:80)
	at oracle.jdbc.driver.T4CMAREngineNIO.prepareForReading(T4CMAREngineNIO.java:98)
	at oracle.jdbc.driver.T4CMAREngineNIO.unmarshalUB1(T4CMAREngineNIO.java:534)
	at oracle.jdbc.driver.T4CTTIfun.receive(T4CTTIfun.java:485)
	at oracle.jdbc.driver.T4CTTIfun.doRPC(T4CTTIfun.java:252)
	at oracle.jdbc.driver.T4C8Oall.doOALL(T4C8Oall.java:612)
	at oracle.jdbc.driver.T4CCallableStatement.doOall8(T4CCallableStatement.java:223)
	at oracle.jdbc.driver.T4CCallableStatement.doOall8(T4CCallableStatement.java:56)
	at oracle.jdbc.driver.T4CCallableStatement.executeForRows(T4CCallableStatement.java:907)
	... 20 common frames omitted
2019-05-10 12:51:32 [pool-1-thread-3] WARN  c.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Connection oracle.jdbc.driver.T4CConnection@1fb473a8 marked as broken because of SQLSTATE(08003), ErrorCode(17008)
java.sql.SQLRecoverableException: Closed Connection
	at oracle.jdbc.driver.PhysicalConnection.clearWarnings(PhysicalConnection.java:2573)
	at com.zaxxer.hikari.pool.ProxyConnection.close(ProxyConnection.java:246)
	at org.utplsql.cli.ReporterManager.lambda$startReporterGatherers$0(ReporterManager.java:130)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
2019-05-10 12:51:32 [pool-1-thread-2] WARN  c.zaxxer.hikari.pool.ProxyConnection - HikariPool-1 - Connection oracle.jdbc.driver.T4CConnection@742dfdaf marked as broken because of SQLSTATE(08003), ErrorCode(17008)
java.sql.SQLRecoverableException: Closed Connection
	at oracle.jdbc.driver.PhysicalConnection.clearWarnings(PhysicalConnection.java:2573)
	at com.zaxxer.hikari.pool.ProxyConnection.close(ProxyConnection.java:246)
	at org.utplsql.cli.ReporterManager.lambda$startReporterGatherers$0(ReporterManager.java:130)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)

pesse commented on May 13, 2019
pesse
on May 13, 2019
Member
More actions
For we don't necessarily need a connection pool, I'll try to remove HikariCP completely.
Reacted by John
Reacted by John
Reacted by John
dmpe commented on May 13, 2019
dmpe
on May 13, 2019
Contributor
More actions
ok, that sounds awesome if it can be done. Actually I wanted to build several versions of utplsql-cli with different HakariCP and jdbc drivers to test it out where the problem may be. i would try to report my results on this friday...though do no wait on me, just go ahead.

EDIT:
@pesse ok. so i have just tried 2 recent versions of utPLSQL with different versions of Hakari and jdbc

For utPLSQL 3.1.6 code base:

Hakari 2.7.9 and 3.3.1 did not work

For utPLSQL 3.1.2 code base:

Hakari 2.7.9 and 3.3.1 did not work
what works is only 2.7.2 version with this codebase, with jdbc7.

guicampos commented on Jun 5, 2019

guicampos

on Jun 5, 2019

More actions

I had a similar issue:

UtPLSQL core: v3.1.6.2735
Oracle Database 12.1.0.2
utPLSQL-cli 3.1.6.local
utPLSQL-java-api 3.1.6.411
Java-Version: 1.8.0_211
ojdbc7.jar

When i first executed the command:

../utPLSQL-cli/bin/utplsql run -d user/passwd@mydb:1521/mysid -source_path=sources -test_path=tests -f=ut_documentation_reporter -c -f=ut_coverage_sonar_reporter -o=coverage.xml -f=ut_sonar_test_reporter -o=test_results.xml --failure-exit-code=0

The command hanged for sometime with

##################### utPLSQL cli ######################
#                                                      #
#   utPLSQL-cli 3.1.6.local                            #
#   utPLSQL-java-api 3.1.6.411                         #
#   Java-Version: 1.8.0_211                            #
#   ORACLE_HOME: /u01/app/oracle/product/12.1.0/db_1   #
#   NLS_LANG: null                                     #
#                                                      #
#   Thanks for testing!                                #
#                                                      #
########################################################

HikariPool-1 - Driver does not support get/set network timeout for connections. (Recurso não suportado)
Use connection string jdbc:oracle:oci8:****/****@mydb:1521/mysid
Successfully connected to database. UtPLSQL core: v3.1.6.2735
Oracle-Version: 12.1.0.2.0
Running tests now.
--------------------------------------
TestRunner initialized
Running on utPLSQL v3.1.6.2735
Initializing reporters
Detected Oracle driver stuck during Statement initialization
WARNING: Caught Oracle stuck during creation of Runner-Statement. Retrying (1)

After a quite long wait time, and every time it retried the warning was reissued

##################### utPLSQL cli ######################
#                                                      #
#   utPLSQL-cli 3.1.6.local                            #
#   utPLSQL-java-api 3.1.6.411                         #
#   Java-Version: 1.8.0_211                            #
#   ORACLE_HOME: /u01/app/oracle/product/12.1.0/db_1   #
#   NLS_LANG: null                                     #
#                                                      #
#   Thanks for testing!                                #
#                                                      #
########################################################

HikariPool-2 - Driver does not support get/set network timeout for connections. (Recurso não suportado)
Use connection string jdbc:oracle:oci8:****/****@mydb:1521/mysid
Successfully connected to database. UtPLSQL core: v3.1.6.2735
Oracle-Version: 12.1.0.2.0
Running tests now.
--------------------------------------
TestRunner initialized
Running on utPLSQL v3.1.6.2735
Initializing reporters
Detected Oracle driver stuck during Statement initialization
WARNING: Caught Oracle stuck during creation of Runner-Statement. Retrying (2)
##################### utPLSQL cli ######################
#                                                      #
#   utPLSQL-cli 3.1.6.local                            #
#   utPLSQL-java-api 3.1.6.411                         #
#   Java-Version: 1.8.0_211                            #
#   ORACLE_HOME: /u01/app/oracle/product/12.1.0/db_1   #
#   NLS_LANG: null                                     #
#                                                      #
#   Thanks for testing!                                #
#                                                      #
########################################################

HikariPool-3 - Driver does not support get/set network timeout for connections. (Recurso não suportado)
Use connection string jdbc:oracle:oci8:****/****@mydb:1521/mysid
Successfully connected to database. UtPLSQL core: v3.1.6.2735
Oracle-Version: 12.1.0.2.0
Running tests now.
--------------------------------------
TestRunner initialized
Running on utPLSQL v3.1.6.2735
Initializing reporters
Detected Oracle driver stuck during Statement initialization
WARNING: Caught Oracle stuck during creation of Runner-Statement. Retrying (3)

after the 4th attempt the test runned smoothly:

##################### utPLSQL cli ######################
#                                                      #
#   utPLSQL-cli 3.1.6.local                            #
#   utPLSQL-java-api 3.1.6.411                         #
#   Java-Version: 1.8.0_211                            #
#   ORACLE_HOME: /u01/app/oracle/product/12.1.0/db_1   #
#   NLS_LANG: null                                     #
#                                                      #
#   Thanks for testing!                                #
#                                                      #
########################################################

HikariPool-4 - Driver does not support get/set network timeout for connections. (Recurso não suportado)
Use connection string jdbc:oracle:oci8:****/****@mydb:1521/mysid
Successfully connected to database. UtPLSQL core: v3.1.6.2735
Oracle-Version: 12.1.0.2.0
Running tests now.
--------------------------------------
TestRunner initialized
Running on utPLSQL v3.1.6.2735
Initializing reporters
Running tests
teste de teste
  resultado final [,046 sec] (FAILED - 1)


Failures:

  1) test_resultado_final
      Actual: 'TESTE NAO OK' (varchar2) was expected to equal: 'Teste OK' (varchar2)
      at "ESMPU.TEST_PKG_TESTE", line 4 ut.expect(pkg_teste.resultado_final).to_equal('Teste OK');


Finished in ,048334 seconds
1 tests, 1 failed, 0 errored, 0 disabled, 0 warning(s)

--------------------------------------
All tests done.

And now there's no more wait time in new executions.

I'm sending my current debug output, maybe it can help solving it.

and Hey! utPLSQL is awesome!
utplsql-cli-log.txt

pesse
closed this as completedin #158 on Jun 27, 2019
pesse
reopened this on Jun 27, 2019
pesse commented on Jun 27, 2019
pesse
on Jun 27, 2019
Member
More actions
Hey @DrErique @dmpe @guicampos
could you try out the latest cli and tell me if you still experience the stuck problems?
https://bintray.com/utplsql/utPLSQL-cli/download_file?file_path=utPLSQL-cli-develop-201906272140.zip
Reacted by John
Reacted by John
DrErique commented on Jun 28, 2019
DrErique
on Jun 28, 2019 via email
Author
More actions
Hello Samuel, Thanks for contacting. I'll try some builds with that next week and tell you about the results. Nice weekend ! Mit freundlichen Grüßen Derik Wehrmann
…

_________________________________________________________________ Tel: -551 | Test- und Releasemanager | IT SCM Von: Samuel Nitsche <[email protected]> Gesendet: Donnerstag, 27. Juni 2019 23:49 An: utPLSQL/utPLSQL-cli <[email protected]> Cc: Wehrmann, Derik <[email protected]>; Mention <[email protected]> Betreff: Re: [utPLSQL/utPLSQL-cli] Detected Oracle Driver stuck during Statement initialization (#145) Hey @DrErique<https://github.com/DrErique> @dmpe<https://github.com/dmpe> @guicampos<https://github.com/guicampos> could you try out the latest cli and tell me if you still experience the stuck problems? https://bintray.com/utplsql/utPLSQL-cli/download_file?file_path=utPLSQL-cli-develop-201906272140.zip — You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub<#145?email_source=notifications&email_token=AIPTY44HQ6ISYACF6PY3HCDP4UYTTA5CNFSM4HJLZYZKYY3PNVWWK3TUL52HS4DFVREXG43VMVBW63LNMVXHJKTDN5WW2ZLOORPWSZGODYYPEEQ#issuecomment-506524178>, or mute the thread<https://github.com/notifications/unsubscribe-auth/AIPTY44MEWJIDLG6DYQN34LP4UYTTANCNFSM4HJLZYZA>.
19 remaining items

rafael-trevisan commented on Jun 29, 2020

rafael-trevisan

on Jun 29, 2020

More actions

19.0.0.0.0
19.0.0
v3.1.10.3349
Oracle Database 19c Standard Edition 2 Release 19.0.0.0.0 - Production
Oracle Database 19c Standard Edition 2 Release 19.0.0.0.0 - Production Version 19.7.0.0.0
Oracle Database 19c Standard Edition 2 Release 19.0.0.0.0 - Production
NLS_LANGUAGE	ENGLISH
NLS_TERRITORY	CANADA
NLS_CURRENCY	$
NLS_ISO_CURRENCY	CANADA
NLS_NUMERIC_CHARACTERS	.,
NLS_CALENDAR	GREGORIAN
NLS_DATE_FORMAT	DD-MON-YYYY
NLS_DATE_LANGUAGE	ENGLISH
NLS_SORT	BINARY
NLS_TIME_FORMAT	HH24:MI:SSXFF
NLS_TIMESTAMP_FORMAT	DD-MON-YYYY HH:MI:SSXFF AM
NLS_TIME_TZ_FORMAT	HH24:MI:SSXFF TZR
NLS_TIMESTAMP_TZ_FORMAT	DD-MON-YYYY HH:MI:SSXFF AM TZR
NLS_DUAL_CURRENCY	$
NLS_COMP	BINARY
NLS_LENGTH_SEMANTICS	BYTE
NLS_NCHAR_CONV_EXCP	FALSE

rafael-trevisan commented on Jun 29, 2020

rafael-trevisan

on Jun 29, 2020

More actions

I did a test using the OJDBC8 from Oracle website and the message was a bit more verbose:

#   Thanks for testing!                #
#                                      #
########################################

Use connection string jdbc:oracle:thin:****/****@***
Successfully connected to database. UtPLSQL core: v3.1.10.3349
Oracle-Version: 19.0.0.0.0
Running tests now.
--------------------------------------
TestRunner initialized
Running on utPLSQL v3.1.10.3349
Initializing reporters
Detected Oracle driver stuck during Statement initialization
java.lang.NullPointerException
	at oracle.net.nt.TcpNTAdapter.abort(TcpNTAdapter.java:423)
	at oracle.net.ns.NSProtocol.abort(NSProtocol.java:532)
	at oracle.jdbc.driver.T4CConnection.doAbort(T4CConnection.java:5161)
	at oracle.jdbc.driver.PhysicalConnection.abort(PhysicalConnection.java:9353)
	at org.utplsql.cli.RunTestRunnerTask.call(RunTestRunnerTask.java:50)
	at org.utplsql.cli.RunTestRunnerTask.call(RunTestRunnerTask.java:24)
	at java.util.concurrent.FutureTask.run(FutureTask.java:266)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
##[error]Process completed with exit code 1.```

rafael-trevisan commented on Jun 29, 2020
rafael-trevisan
on Jun 29, 2020
More actions
Again, the issue is intermittent. If I just re-run the job to re-execute the tests is may pass - or not.
pesse commented on Jun 30, 2020
pesse
on Jun 30, 2020
Member
More actions
Hey @rafael-trevisan , could you attach the full logs of a failing run with -d (for extensive debug messages)?

This looks different to the original stuck statement error.

rafael-trevisan commented on Jul 23, 2020

rafael-trevisan

on Jul 23, 2020

More actions

Here is it @pesse

2020-07-22 21:38:46 [main] INFO  org.utplsql.cli.RunAction - ############# utPLSQL cli ##############
#                                      #
#   utPLSQL-cli 3.1.8-SNAPSHOT.local   #
#   utPLSQL-java-api 3.1.8.546         #
#   Java-Version: 11.0.7               #
#   ORACLE_HOME: null                  #
#   NLS_LANG: null                     #
#                                      #
#   Thanks for testing!                #
#                                      #
########################################
2020-07-22 21:38:46 [main] INFO  org.utplsql.cli.RunAction - 
2020-07-22 21:38:47 [main] INFO  o.u.c.d.TestedDataSourceProvider - Use connection string jdbc:oracle:thin:****/****@****
2020-07-22 21:38:49 [main] INFO  org.utplsql.cli.RunAction - Successfully connected to database. UtPLSQL core: v3.1.10.3349
2020-07-22 21:38:49 [main] INFO  org.utplsql.cli.RunAction - Oracle-Version: 19.0.0.0.0
2020-07-22 21:38:50 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_COVERAGE_SONAR_REPORTER, ID: AB156ECD41596161E0530100007FDCCD
2020-07-22 21:38:51 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_SONAR_TEST_REPORTER, ID: AB156ECD415D6161E0530100007FDCCD
2020-07-22 21:38:51 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_DOCUMENTATION_REPORTER, ID: AB156ECD41616161E0530100007FDCCD
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/db
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__projects_ai.plsql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/create-schema.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/install-apex.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/drop-schema.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/v2020.01.01.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/.DS_Store
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_body.pkb
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__const_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__plans.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__projects.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__roles.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__something_variations.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__accounts.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users_ext.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__environments.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__account_users.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__somethings.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__user_credentials.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__errors.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__history.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__teams.sql
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/test
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_spec.pks
2020-07-22 21:38:51 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_body.pkb
2020-07-22 21:38:52 [pool-1-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - Running tests now.
2020-07-22 21:38:52 [pool-1-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - --------------------------------------
2020-07-22 21:38:52 [pool-1-thread-1] INFO  org.utplsql.api.TestRunner - TestRunner initialized
2020-07-22 21:38:52 [pool-1-thread-1] INFO  org.utplsql.api.TestRunner - Running on utPLSQL v3.1.10.3349
2020-07-22 21:38:52 [pool-1-thread-1] INFO  org.utplsql.api.TestRunner - Initializing reporters
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__projects_ai.plsql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/create-schema.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/install-apex.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/drop-schema.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/v2020.01.01.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/.DS_Store
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_body.pkb
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__const_spec.pks
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__plans.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__projects.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__roles.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__something_variations.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__accounts.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users_ext.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__environments.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__account_users.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__somethings.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__user_credentials.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__errors.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__history.sql
2020-07-22 21:38:52 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__teams.sql
2020-07-22 21:38:54 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:38:54 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_spec.pks
2020-07-22 21:38:54 [pool-2-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_body.pkb
2020-07-22 21:38:54 [pool-1-thread-1] ERROR org.utplsql.api.TestRunner - Detected Oracle driver stuck during Statement initialization
2020-07-22 21:38:54 [main] WARN  org.utplsql.cli.RunAction - WARNING: Caught Oracle stuck during creation of Runner-Statement. Retrying (1)
2020-07-22 21:38:54 [main] INFO  org.utplsql.cli.RunAction - ############# utPLSQL cli ##############
#                                      #
#   utPLSQL-cli 3.1.8-SNAPSHOT.local   #
#   utPLSQL-java-api 3.1.8.546         #
#   Java-Version: 11.0.7               #
#   ORACLE_HOME: null                  #
#   NLS_LANG: null                     #
#                                      #
#   Thanks for testing!                #
#                                      #
########################################
2020-07-22 21:38:54 [main] INFO  org.utplsql.cli.RunAction - 
2020-07-22 21:38:55 [main] INFO  o.u.c.d.TestedDataSourceProvider - Use connection string jdbc:oracle:thin:****/****@****
2020-07-22 21:38:56 [main] INFO  org.utplsql.cli.RunAction - Successfully connected to database. UtPLSQL core: v3.1.10.3349
2020-07-22 21:38:56 [main] INFO  org.utplsql.cli.RunAction - Oracle-Version: 19.0.0.0.0
2020-07-22 21:38:58 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_COVERAGE_SONAR_REPORTER, ID: AB156F3F69C1617EE0530100007F7B5F
2020-07-22 21:38:58 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_SONAR_TEST_REPORTER, ID: AB156F3F69C5617EE0530100007F7B5F
2020-07-22 21:38:59 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_DOCUMENTATION_REPORTER, ID: AB156F3F69C9617EE0530100007F7B5F
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/db
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__projects_ai.plsql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/create-schema.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/install-apex.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/drop-schema.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/v2020.01.01.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/.DS_Store
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_body.pkb
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__const_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__plans.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__projects.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__roles.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__something_variations.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__accounts.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users_ext.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__environments.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__account_users.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__somethings.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__user_credentials.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__errors.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__history.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__teams.sql
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/test
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_spec.pks
2020-07-22 21:38:59 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_body.pkb
2020-07-22 21:39:00 [pool-4-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - Running tests now.
2020-07-22 21:39:00 [pool-4-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - --------------------------------------
2020-07-22 21:39:00 [pool-4-thread-1] INFO  org.utplsql.api.TestRunner - TestRunner initialized
2020-07-22 21:39:00 [pool-4-thread-1] INFO  org.utplsql.api.TestRunner - Running on utPLSQL v3.1.10.3349
2020-07-22 21:39:00 [pool-4-thread-1] INFO  org.utplsql.api.TestRunner - Initializing reporters
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__projects_ai.plsql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/create-schema.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/install-apex.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/drop-schema.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/v2020.01.01.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/.DS_Store
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_body.pkb
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__const_spec.pks
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__plans.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__projects.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__roles.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__something_variations.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__accounts.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users_ext.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__environments.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__account_users.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__somethings.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__user_credentials.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__errors.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__history.sql
2020-07-22 21:39:00 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__teams.sql
2020-07-22 21:39:01 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:39:01 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_spec.pks
2020-07-22 21:39:01 [pool-5-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_body.pkb
2020-07-22 21:39:02 [pool-4-thread-1] ERROR org.utplsql.api.TestRunner - Detected Oracle driver stuck during Statement initialization
2020-07-22 21:39:02 [main] WARN  org.utplsql.cli.RunAction - WARNING: Caught Oracle stuck during creation of Runner-Statement. Retrying (2)
2020-07-22 21:39:02 [main] INFO  org.utplsql.cli.RunAction - ############# utPLSQL cli ##############
#                                      #
#   utPLSQL-cli 3.1.8-SNAPSHOT.local   #
#   utPLSQL-java-api 3.1.8.546         #
#   Java-Version: 11.0.7               #
#   ORACLE_HOME: null                  #
#   NLS_LANG: null                     #
#                                      #
#   Thanks for testing!                #
#                                      #
########################################
2020-07-22 21:39:02 [main] INFO  org.utplsql.cli.RunAction - 
2020-07-22 21:39:03 [main] INFO  o.u.c.d.TestedDataSourceProvider - Use connection string jdbc:oracle:thin:****/****@****
2020-07-22 21:39:03 [main] INFO  org.utplsql.cli.RunAction - Successfully connected to database. UtPLSQL core: v3.1.10.3349
2020-07-22 21:39:04 [main] INFO  org.utplsql.cli.RunAction - Oracle-Version: 19.0.0.0.0
2020-07-22 21:39:05 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_COVERAGE_SONAR_REPORTER, ID: AB156FB0581B619FE0530100007F0719
2020-07-22 21:39:06 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_SONAR_TEST_REPORTER, ID: AB156FB0581F619FE0530100007F0719
2020-07-22 21:39:06 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_DOCUMENTATION_REPORTER, ID: AB156FB05823619FE0530100007F0719
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/db
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__projects_ai.plsql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/create-schema.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/install-apex.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/drop-schema.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/v2020.01.01.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/.DS_Store
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_body.pkb
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__const_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__plans.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__projects.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__roles.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__something_variations.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__accounts.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users_ext.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__environments.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__account_users.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__somethings.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__user_credentials.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__errors.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__history.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__teams.sql
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/test
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_spec.pks
2020-07-22 21:39:06 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_body.pkb
2020-07-22 21:39:07 [pool-7-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - Running tests now.
2020-07-22 21:39:07 [pool-7-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - --------------------------------------
2020-07-22 21:39:07 [pool-7-thread-1] INFO  org.utplsql.api.TestRunner - TestRunner initialized
2020-07-22 21:39:07 [pool-7-thread-1] INFO  org.utplsql.api.TestRunner - Running on utPLSQL v3.1.10.3349
2020-07-22 21:39:07 [pool-7-thread-1] INFO  org.utplsql.api.TestRunner - Initializing reporters
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__projects_ai.plsql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/create-schema.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/install-apex.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/drop-schema.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/v2020.01.01.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/.DS_Store
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_body.pkb
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__const_spec.pks
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__plans.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__projects.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__roles.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__something_variations.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__accounts.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users_ext.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__environments.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__account_users.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__somethings.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__user_credentials.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__errors.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__history.sql
2020-07-22 21:39:07 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__teams.sql
2020-07-22 21:39:08 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:39:08 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_spec.pks
2020-07-22 21:39:08 [pool-8-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_body.pkb
2020-07-22 21:39:09 [pool-7-thread-1] ERROR org.utplsql.api.TestRunner - Detected Oracle driver stuck during Statement initialization
2020-07-22 21:39:09 [main] WARN  org.utplsql.cli.RunAction - WARNING: Caught Oracle stuck during creation of Runner-Statement. Retrying (3)
2020-07-22 21:39:09 [main] INFO  org.utplsql.cli.RunAction - ############# utPLSQL cli ##############
#                                      #
#   utPLSQL-cli 3.1.8-SNAPSHOT.local   #
#   utPLSQL-java-api 3.1.8.546         #
#   Java-Version: 11.0.7               #
#   ORACLE_HOME: null                  #
#   NLS_LANG: null                     #
#                                      #
#   Thanks for testing!                #
#                                      #
########################################
2020-07-22 21:39:09 [main] INFO  org.utplsql.cli.RunAction - 
2020-07-22 21:39:10 [main] INFO  o.u.c.d.TestedDataSourceProvider - Use connection string jdbc:oracle:thin:****/****@****
2020-07-22 21:39:11 [main] INFO  org.utplsql.cli.RunAction - Successfully connected to database. UtPLSQL core: v3.1.10.3349
2020-07-22 21:39:11 [main] INFO  org.utplsql.cli.RunAction - Oracle-Version: 19.0.0.0.0
2020-07-22 21:39:13 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_COVERAGE_SONAR_REPORTER, ID: AB157021C63A61BCE0530100007FE167
2020-07-22 21:39:13 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_SONAR_TEST_REPORTER, ID: AB157021C63E61BCE0530100007FE167
2020-07-22 21:39:14 [main] DEBUG org.utplsql.api.reporter.Reporter - Database-reporter initialized, Type: UT_DOCUMENTATION_REPORTER, ID: AB157021C64261BCE0530100007FE167
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/db
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__projects_ai.plsql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/create-schema.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/install-apex.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/util/drop-schema.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/scripts/v2020.01.01.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/.DS_Store
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__team_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__util_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__role_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__error_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__plan_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__security_body.pkb
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__environment_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__something_variation_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__project_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__account_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/packages/r__const_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__plans.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__projects.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__roles.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__something_variations.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__accounts.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users_ext.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__users.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__environments.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__account_users.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__somethings.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__user_credentials.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__errors.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__history.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/db/views/r__teams.sql
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - BaseDir: /Users/username/Projects/project_name/reponame
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - SourcePath: server/test
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - Getting FileMapperOptions - Files: 
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_spec.pks
2020-07-22 21:39:14 [main] DEBUG org.utplsql.cli.RunAction - server/test/packages/r__test_util_body.pkb
2020-07-22 21:39:14 [pool-10-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - Running tests now.
2020-07-22 21:39:14 [pool-10-thread-1] INFO  org.utplsql.cli.RunTestRunnerTask - --------------------------------------
2020-07-22 21:39:14 [pool-10-thread-1] INFO  org.utplsql.api.TestRunner - TestRunner initialized
2020-07-22 21:39:15 [pool-10-thread-1] INFO  org.utplsql.api.TestRunner - Running on utPLSQL v3.1.10.3349
2020-07-22 21:39:15 [pool-10-thread-1] INFO  org.utplsql.api.TestRunner - Initializing reporters
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/procedures/r__generate_api_methods.plsql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__projects_ai.plsql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/triggers/r__user_credentials_biu_hash_password.plsql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/create-schema.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/install-apex.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/util/drop-schema.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__002-enable-audit.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__003-load-data.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/callbacks/afterMigrate__001-compile-schema.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/scripts/v2020.01.01.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/.DS_Store
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__team_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__util_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__role_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__error_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__plan_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__security_body.pkb
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__environment_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__something_variation_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__project_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__account_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/packages/r__const_spec.pks
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__plans.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__projects.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__roles.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__something_variations.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__accounts.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users_ext.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__users.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__environments.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__account_users.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__somethings.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__user_credentials.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__errors.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__history.sql
2020-07-22 21:39:15 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/db/views/r__teams.sql
2020-07-22 21:39:16 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Building fileMappingArray
2020-07-22 21:39:16 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_spec.pks
2020-07-22 21:39:16 [pool-11-thread-1] DEBUG o.utplsql.api.testRunner.FileMapper - Path: server/test/packages/r__test_util_body.pkb
2020-07-22 21:39:17 [pool-10-thread-1] ERROR org.utplsql.api.TestRunner - Detected Oracle driver stuck during Statement initialization
2020-07-22 21:39:17 [main] WARN  org.utplsql.cli.RunAction - WARNING: Caught Oracle stuck during creation of Runner-Statement. Retrying (4)

rafael-trevisan commented on Jul 23, 2020
rafael-trevisan
on Jul 23, 2020
More actions
I can see a strange pattern between these failures and around 4 sessions (all from JDBC Thin Client) getting stuck while running the following command:

SELECT TEXT, ITEM_TYPE FROM TABLE((:B1 ).GET_LINES(:B2 , :B3 ))

Every time utPLSQL retries "Retrying (n)" I can see another 3 new sessions running the same funny select. The wait event for these sessions is PL/SQL lock timer 🤔

Once utPLSQL finally fails, the sessions will be still "Active" for around 2 or 3 minutes.
rafael-trevisan commented on Jul 23, 2020
rafael-trevisan
on Jul 23, 2020
More actions
Ha! The number of hanging session is directly related to the number of reports I am generating in my tests!

In my case, I am using the following reports:

-f=ut_coverage_sonar_reporter -o=log/coverage.xml \ -f=ut_sonar_test_reporter -o=log/test-results.xml \ -f=ut_documentation_reporter -o=log/test-results.log -s

Another interesting finding is that I have only 1 report, I get the error once let's say every 10 times I run. With the 3 reports altogether I get the error every 2 or 3 times. Hope that makes sense and helps narrow down this nasty bug.
tplazaro commented on Dec 14, 2020
tplazaro
on Dec 14, 2020
More actions
Is there any update on this one, any workaround? I'm having the same issue :(
pesse commented on Dec 14, 2020
pesse
on Dec 14, 2020
Member
More actions
This issue is very likely an Oracle bug and highly related to your used Oracle database, used driver etc.
Please provide

your database version/platform

your jdbc driver version

whether the problem occurs reproducably
pesse commented on Jan 27, 2021
pesse
on Jan 27, 2021
Member
More actions
@rafael-trevisan @tplazaro can you try the steps mentioned in https://github.com/utPLSQL/utPLSQL/issues/1121?

Either access the file $JAVA_HOME/jre/lib/security/java.security and change securerandom.source=file:/dev/random to securerandom.source=file:/dev/urandom

Or set up JAVA_TOOL_OPTIONS:

export JAVA_TOOL_OPTIONS='-Djava.security.egd=file:/dev/./urandom -Dsecurerandom.source=file:/dev/./urandom'
pesse commented on Jan 28, 2021
pesse
on Jan 28, 2021
Member
More actions
After sleeping over it I have little hopes this is the problem source (I'm actually quite convinced it's not)
I would still love to get some feedback from you folks, since this is something I cannot test/reproduce myself.
dmpe commented on Jan 28, 2021
dmpe
on Jan 28, 2021
Contributor
More actions
Hi, I am sorry but cannot test it anymore :(

OsBlaineOra commented on Jul 15, 2021

OsBlaineOra

on Jul 15, 2021

More actions

I am unable to run any code coverage reporter from the cli 9/10 times.

Switching back to running project based coverage through a .sql script requires that I list out every file to be checked. (Unless I'm wrong about that).

Here's how I'm running it from .sql

Create a .sql script to run coverage for corbertura and sonar. (If you're not using sqlcl, remove the !rm... lines)

utplsql_coverage.sql

set serveroutput on 
set timing off
set linesize 32767
set termout off
set feedback off
set verify off

!rm cobertura_coverage.xml
spool cobertura_coverage.xml
begin
  ut.run(
    ut_varchar2_list('unit_test'),
    ut_coverage_cobertura_reporter(),
    a_source_file_mappings =>
      ut_file_mapper.build_file_mappings(
        a_file_paths  => ut_varchar2_list('&1')
        ),
    a_test_file_mappings =>
      ut_file_mapper.build_file_mappings(
        a_file_paths  => ut_varchar2_list('&2')
      )
  );
end;
/
spool off

!rm sonar_coverage.xml
spool sonar_coverage.xml
begin
  ut.run(
    ut_varchar2_list('unit_test'),
    ut_coverage_sonar_reporter(),
    a_source_file_mappings =>
      ut_file_mapper.build_file_mappings(
        a_file_paths  => ut_varchar2_list('&1')
        ),
    a_test_file_mappings =>
      ut_file_mapper.build_file_mappings(
        a_file_paths  => ut_varchar2_list('&2')
      )
  );
end;
/
spool off
exit;

My source files are in source/plsql, my tests are in tests/utplsql

Create an env for my source and test list.

export source_files=$(find source/plsql/ -type f \( -name "*.pkb" -o -name "*.fnc" -o -name "*.prc" -o -name "*.tpb" -o -name "*.trg" \) -printf "'%p'\0" | tr '\0' , | sed 's/,$//')
echo $source_files

export test_files=$(find tests/utplsql/ -type f \( -name "*.pkb" -o -name "*.fnc" -o -name "*.prc" -o -name "*.tpb" -o -name "*.trg" \) -printf "'%p'\0" | tr '\0' , | sed 's/,$//')
echo $test_files

Run the script

sql <user>/<password>@<connect_string> @utplsql_coverage.sql $source_files $test_files

I can use this in my CICD pipeline until we can find a fix for the stuck problem.

jgebal commented on Sep 27, 2026
jgebal
on Sep 27, 2026
Member
More actions
Closing as removal of connection Hikari connection pool in #158 seem to fix it
jgebal
closed this as completed on Sep 27, 2026

Metadata

Assignees

No one assigned

Labels

No labels

Type

No type

Projects

No projects

Milestone

No milestone

Relationships

None yet

Development

No branches or pull requests

Issue actions

You are visitor 01402503 — GeezerVison does not store the pages you look up.
Best viewed with Netscape Navigator 4.7 or Internet Explorer 6 at 800×600. No cookies required.

GeezerVison

Detected Oracle Driver stuck during Statement initialization #145

Description

Activity

pesse commented on Apr 30, 2019

DrErique commented on Apr 30, 2019

pesse commented on May 3, 2019

DrErique commented on May 3, 2019

DrErique commented on May 8, 2019

pesse commented on May 9, 2019

DrErique commented on May 9, 2019

dmpe commented on May 10, 2019

pesse commented on May 13, 2019

dmpe commented on May 13, 2019

For utPLSQL 3.1.6 code base:

For utPLSQL 3.1.2 code base:

guicampos commented on Jun 5, 2019

pesse commented on Jun 27, 2019

DrErique commented on Jun 28, 2019

19 remaining items

rafael-trevisan commented on Jun 29, 2020

rafael-trevisan commented on Jun 29, 2020

rafael-trevisan commented on Jun 29, 2020

pesse commented on Jun 30, 2020

rafael-trevisan commented on Jul 23, 2020

rafael-trevisan commented on Jul 23, 2020

rafael-trevisan commented on Jul 23, 2020

tplazaro commented on Dec 14, 2020

pesse commented on Dec 14, 2020

pesse commented on Jan 27, 2021

pesse commented on Jan 28, 2021

dmpe commented on Jan 28, 2021

OsBlaineOra commented on Jul 15, 2021

jgebal commented on Sep 27, 2026

Metadata

Metadata

Assignees

Labels

Type

Projects

Milestone

Relationships

Development

Issue actions