quarkusio / quarkus

Quarkus: Supersonic Subatomic Java.
https://quarkus.io
Apache License 2.0
13.63k stars 2.64k forks source link

QuarkusTest hang in IntelliJ IDEA for master and quarkus 1.3+ but not 1.2 #7311

Closed ge0ffrey closed 4 years ago

ge0ffrey commented 4 years ago

To reproduce:

This reproduces with the IntelliJ Ultimate, both in the latest 2019.3.3 and an earlier version 2019.2.2. This prevents normal debugging of tests in IntelliJ. Everything works fine in maven (CI's won't detect this problem). This reproduces after system reboot and IntelliJ reboot.

During there run, an InvocationTargetException occurs (see debug screenshot below, but when that exception is being written to System.err, it deadlocks on PrintStream, causing nothing to show up and the test to run to hang.

Selection_269

Suspected cause

On 21-Januari this changes happened in the quarkus bom, from

   <junit.jupiter.version>5.5.2</junit.jupiter.version>

to

    <junit.jupiter.version>5.6.0</junit.jupiter.version>
geoand commented 4 years ago

I was unable to reproduce this

ge0ffrey commented 4 years ago

Georgios tried on development branch. I tried on master and switched hibernate-orm-quickstart to use H2 in memory. I 'll investigate further.

geoand commented 4 years ago

@ge0ffrey were you able to find any more information?

ge0ffrey commented 4 years ago

I am reproducing it on the development branch too, with hibernate-orm-quickstart. FruitsEndpointTest hangs.

I did do something extra on the reproduces list (to avoid having to do docker daemon installation):

geoand commented 4 years ago

How is h2 being started?

ge0ffrey commented 4 years ago

In the JDBC driver, with "jdbc:h2:mem:quarkus_test". No need to start any DB process.

gastaldi commented 4 years ago

I can't reproduce that error either. I followed the steps in https://github.com/quarkusio/quarkus/issues/7311#issuecomment-589595484 but no luck :(

This is the output in my Intellij:

/home/ggastald/.sdkman/candidates/java/8.0.232-open/bin/java -ea -Didea.test.cyclic.buffer.size=1048576 -javaagent:/home/ggastald/.local/share/JetBrains/Toolbox/apps/IDEA-U/ch-0/193.6494.35/lib/idea_rt.jar=44567:/home/ggastald/.local/share/JetBrains/Toolbox/apps/IDEA-U/ch-0/193.6494.35/bin -Dfile.encoding=UTF-8 -classpath /home/ggastald/.local/share/JetBrains/Toolbox/apps/IDEA-U/ch-0/193.6494.35/lib/idea_rt.jar:/home/ggastald/.local/share/JetBrains/Toolbox/apps/IDEA-U/ch-0/193.6494.35/plugins/junit/lib/junit5-rt.jar:/home/ggastald/.local/share/JetBrains/Toolbox/apps/IDEA-U/ch-0/193.6494.35/plugins/junit/lib/junit-rt.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/charsets.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/cldrdata.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/dnsns.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/jaccess.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/localedata.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/nashorn.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/sunec.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/sunjce_provider.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/sunpkcs11.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/ext/zipfs.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/jce.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/jsse.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/management-agent.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/resources.jar:/home/ggastald/.sdkman/candidates/java/8.0.232-open/jre/lib/rt.jar:/home/ggastald/workspace/quarkus-quickstarts/hibernate-orm-quickstart/target/test-classes:/home/ggastald/workspace/quarkus-quickstarts/hibernate-orm-quickstart/target/classes:/home/ggastald/.m2/repository/io/quarkus/quarkus-hibernate-orm/999-SNAPSHOT/quarkus-hibernate-orm-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-core/999-SNAPSHOT/quarkus-core-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/jakarta/annotation/jakarta.annotation-api/1.3.5/jakarta.annotation-api-1.3.5.jar:/home/ggastald/.m2/repository/jakarta/enterprise/jakarta.enterprise.cdi-api/2.0.2/jakarta.enterprise.cdi-api-2.0.2.jar:/home/ggastald/.m2/repository/jakarta/el/jakarta.el-api/3.0.3/jakarta.el-api-3.0.3.jar:/home/ggastald/.m2/repository/jakarta/interceptor/jakarta.interceptor-api/1.2.5/jakarta.interceptor-api-1.2.5.jar:/home/ggastald/.m2/repository/jakarta/inject/jakarta.inject-api/1.0/jakarta.inject-api-1.0.jar:/home/ggastald/.m2/repository/io/smallrye/config/smallrye-config/1.6.1/smallrye-config-1.6.1.jar:/home/ggastald/.m2/repository/io/smallrye/config/smallrye-config-common/1.6.1/smallrye-config-common-1.6.1.jar:/home/ggastald/.m2/repository/org/eclipse/microprofile/config/microprofile-config-api/1.4/microprofile-config-api-1.4.jar:/home/ggastald/.m2/repository/org/jboss/logging/jboss-logging/3.3.2.Final/jboss-logging-3.3.2.Final.jar:/home/ggastald/.m2/repository/org/jboss/logmanager/jboss-logmanager-embedded/1.0.4/jboss-logmanager-embedded-1.0.4.jar:/home/ggastald/.m2/repository/org/jboss/logging/jboss-logging-annotations/2.1.0.Final/jboss-logging-annotations-2.1.0.Final.jar:/home/ggastald/.m2/repository/org/jboss/threads/jboss-threads/3.0.1.Final/jboss-threads-3.0.1.Final.jar:/home/ggastald/.m2/repository/org/slf4j/slf4j-api/1.7.29/slf4j-api-1.7.29.jar:/home/ggastald/.m2/repository/org/jboss/slf4j/slf4j-jboss-logging/1.2.0.Final/slf4j-jboss-logging-1.2.0.Final.jar:/home/ggastald/.m2/repository/org/graalvm/sdk/graal-sdk/19.3.1/graal-sdk-19.3.1.jar:/home/ggastald/.m2/repository/org/wildfly/common/wildfly-common/1.5.3.Final-format-001/wildfly-common-1.5.3.Final-format-001.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-narayana-jta/999-SNAPSHOT/quarkus-narayana-jta-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/smallrye/reactive/smallrye-reactive-streams-operators/1.0.10/smallrye-reactive-streams-operators-1.0.10.jar:/home/ggastald/.m2/repository/org/eclipse/microprofile/reactive-streams-operators/microprofile-reactive-streams-operators-api/1.0/microprofile-reactive-streams-operators-api-1.0.jar:/home/ggastald/.m2/repository/org/reactivestreams/reactive-streams/1.0.3/reactive-streams-1.0.3.jar:/home/ggastald/.m2/repository/org/eclipse/microprofile/reactive-streams-operators/microprofile-reactive-streams-operators-core/1.0/microprofile-reactive-streams-operators-core-1.0.jar:/home/ggastald/.m2/repository/io/reactivex/rxjava2/rxjava/2.2.17/rxjava-2.2.17.jar:/home/ggastald/.m2/repository/io/smallrye/smallrye-context-propagation-jta/1.0.11/smallrye-context-propagation-jta-1.0.11.jar:/home/ggastald/.m2/repository/io/smallrye/reactive/smallrye-reactive-converter-api/1.0.10/smallrye-reactive-converter-api-1.0.10.jar:/home/ggastald/.m2/repository/org/hibernate/hibernate-core/5.4.12.Final/hibernate-core-5.4.12.Final.jar:/home/ggastald/.m2/repository/net/bytebuddy/byte-buddy/1.10.7/byte-buddy-1.10.7.jar:/home/ggastald/.m2/repository/antlr/antlr/2.7.7/antlr-2.7.7.jar:/home/ggastald/.m2/repository/org/jboss/jandex/2.1.2.Final/jandex-2.1.2.Final.jar:/home/ggastald/.m2/repository/com/fasterxml/classmate/1.3.4/classmate-1.3.4.jar:/home/ggastald/.m2/repository/org/dom4j/dom4j/2.1.1/dom4j-2.1.1.jar:/home/ggastald/.m2/repository/org/hibernate/common/hibernate-commons-annotations/5.1.0.Final/hibernate-commons-annotations-5.1.0.Final.jar:/home/ggastald/.m2/repository/org/hibernate/hibernate-graalvm/5.4.12.Final/hibernate-graalvm-5.4.12.Final.jar:/home/ggastald/.m2/repository/org/glassfish/jaxb/jaxb-runtime/2.3.3-b01/jaxb-runtime-2.3.3-b01.jar:/home/ggastald/.m2/repository/org/glassfish/jaxb/txw2/2.3.3-b01/txw2-2.3.3-b01.jar:/home/ggastald/.m2/repository/com/sun/istack/istack-commons-runtime/3.0.10/istack-commons-runtime-3.0.10.jar:/home/ggastald/.m2/repository/com/sun/activation/jakarta.activation/1.2.1/jakarta.activation-1.2.1.jar:/home/ggastald/.m2/repository/org/jboss/spec/javax/xml/bind/jboss-jaxb-api_2.3_spec/2.0.0.Final/jboss-jaxb-api_2.3_spec-2.0.0.Final.jar:/home/ggastald/.m2/repository/jakarta/persistence/jakarta.persistence-api/2.2.3/jakarta.persistence-api-2.2.3.jar:/home/ggastald/.m2/repository/jakarta/transaction/jakarta.transaction-api/1.3.3/jakarta.transaction-api-1.3.3.jar:/home/ggastald/.m2/repository/org/hibernate/quarkus-local-cache/0.1.0/quarkus-local-cache-0.1.0.jar:/home/ggastald/.m2/repository/com/github/ben-manes/caffeine/caffeine/2.8.0/caffeine-2.8.0.jar:/home/ggastald/.m2/repository/org/checkerframework/checker-qual/2.5.2/checker-qual-2.5.2.jar:/home/ggastald/.m2/repository/com/google/errorprone/error_prone_annotations/2.2.0/error_prone_annotations-2.2.0.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-caffeine/999-SNAPSHOT/quarkus-caffeine-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-agroal/999-SNAPSHOT/quarkus-agroal-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-arc/999-SNAPSHOT/quarkus-arc-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/arc/arc/999-SNAPSHOT/arc-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/org/eclipse/microprofile/context-propagation/microprofile-context-propagation-api/1.0.1/microprofile-context-propagation-api-1.0.1.jar:/home/ggastald/.m2/repository/org/jboss/narayana/jta/narayana-jta/5.10.0.Final/narayana-jta-5.10.0.Final.jar:/home/ggastald/.m2/repository/org/jboss/jboss-transaction-spi/7.6.0.Final/jboss-transaction-spi-7.6.0.Final.jar:/home/ggastald/.m2/repository/org/jboss/spec/javax/resource/jboss-connector-api_1.7_spec/1.0.0.Final/jboss-connector-api_1.7_spec-1.0.0.Final.jar:/home/ggastald/.m2/repository/org/jboss/narayana/jts/narayana-jts-integration/5.10.0.Final/narayana-jts-integration-5.10.0.Final.jar:/home/ggastald/.m2/repository/io/agroal/agroal-api/1.7/agroal-api-1.7.jar:/home/ggastald/.m2/repository/io/agroal/agroal-narayana/1.7/agroal-narayana-1.7.jar:/home/ggastald/.m2/repository/io/agroal/agroal-pool/1.7/agroal-pool-1.7.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-vault-spi/999-SNAPSHOT/quarkus-vault-spi-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-resteasy/999-SNAPSHOT/quarkus-resteasy-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-vertx-http/999-SNAPSHOT/quarkus-vertx-http-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-development-mode-spi/999-SNAPSHOT/quarkus-development-mode-spi-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/security/quarkus-security/1.0.1.Final/quarkus-security-1.0.1.Final.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-vertx-core/999-SNAPSHOT/quarkus-vertx-core-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-netty/999-SNAPSHOT/quarkus-netty-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/netty/netty-codec/4.1.44.Final/netty-codec-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-handler/4.1.44.Final/netty-handler-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/vertx/vertx-core/3.8.5/vertx-core-3.8.5.jar:/home/ggastald/.m2/repository/io/netty/netty-common/4.1.44.Final/netty-common-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-buffer/4.1.44.Final/netty-buffer-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-transport/4.1.44.Final/netty-transport-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-handler-proxy/4.1.44.Final/netty-handler-proxy-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-codec-socks/4.1.44.Final/netty-codec-socks-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-codec-http/4.1.44.Final/netty-codec-http-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-codec-http2/4.1.44.Final/netty-codec-http2-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-resolver/4.1.44.Final/netty-resolver-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-resolver-dns/4.1.44.Final/netty-resolver-dns-4.1.44.Final.jar:/home/ggastald/.m2/repository/io/netty/netty-codec-dns/4.1.44.Final/netty-codec-dns-4.1.44.Final.jar:/home/ggastald/.m2/repository/com/fasterxml/jackson/core/jackson-core/2.10.2/jackson-core-2.10.2.jar:/home/ggastald/.m2/repository/io/vertx/vertx-web/3.8.5/vertx-web-3.8.5.jar:/home/ggastald/.m2/repository/io/vertx/vertx-web-common/3.8.5/vertx-web-common-3.8.5.jar:/home/ggastald/.m2/repository/io/vertx/vertx-auth-common/3.8.5/vertx-auth-common-3.8.5.jar:/home/ggastald/.m2/repository/io/vertx/vertx-bridge-common/3.8.5/vertx-bridge-common-3.8.5.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-resteasy-server-common/999-SNAPSHOT/quarkus-resteasy-server-common-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-resteasy-common/999-SNAPSHOT/quarkus-resteasy-common-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/org/jboss/resteasy/resteasy-core/4.4.2.Final/resteasy-core-4.4.2.Final.jar:/home/ggastald/.m2/repository/org/jboss/spec/javax/ws/rs/jboss-jaxrs-api_2.1_spec/2.0.1.Final/jboss-jaxrs-api_2.1_spec-2.0.1.Final.jar:/home/ggastald/.m2/repository/org/jboss/resteasy/resteasy-core-spi/4.4.2.Final/resteasy-core-spi-4.4.2.Final.jar:/home/ggastald/.m2/repository/jakarta/validation/jakarta.validation-api/2.0.2/jakarta.validation-api-2.0.2.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-resteasy-jsonb/999-SNAPSHOT/quarkus-resteasy-jsonb-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-jsonb/999-SNAPSHOT/quarkus-jsonb-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/org/eclipse/yasson/1.0.6/yasson-1.0.6.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-jsonp/999-SNAPSHOT/quarkus-jsonp-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/org/jboss/resteasy/resteasy-json-binding-provider/4.4.2.Final/resteasy-json-binding-provider-4.4.2.Final.jar:/home/ggastald/.m2/repository/org/glassfish/jakarta.json/1.1.6/jakarta.json-1.1.6.jar:/home/ggastald/.m2/repository/jakarta/json/bind/jakarta.json.bind-api/1.0.2/jakarta.json.bind-api-1.0.2.jar:/home/ggastald/.m2/repository/org/jboss/resteasy/resteasy-json-p-provider/4.4.2.Final/resteasy-json-p-provider-4.4.2.Final.jar:/home/ggastald/.m2/repository/commons-io/commons-io/2.6/commons-io-2.6.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-jdbc-h2/999-SNAPSHOT/quarkus-jdbc-h2-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/com/h2database/h2/1.4.197/h2-1.4.197.jar:/home/ggastald/.m2/repository/org/locationtech/jts/jts-core/1.15.0/jts-core-1.15.0.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-junit5/999-SNAPSHOT/quarkus-junit5-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-bootstrap-core/999-SNAPSHOT/quarkus-bootstrap-core-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/org/ow2/asm/asm/7.3.1/asm-7.3.1.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-embedder/3.5.4/maven-embedder-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-settings/3.5.4/maven-settings-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-core/3.5.4/maven-core-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-artifact/3.5.4/maven-artifact-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-plugin-api/3.5.4/maven-plugin-api-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-model/3.5.4/maven-model-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-model-builder/3.5.4/maven-model-builder-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-builder-support/3.5.4/maven-builder-support-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/resolver/maven-resolver-api/1.1.1/maven-resolver-api-1.1.1.jar:/home/ggastald/.m2/repository/org/apache/maven/resolver/maven-resolver-util/1.1.1/maven-resolver-util-1.1.1.jar:/home/ggastald/.m2/repository/org/apache/maven/shared/maven-shared-utils/3.2.1/maven-shared-utils-3.2.1.jar:/home/ggastald/.m2/repository/com/google/inject/guice/4.2.0/guice-4.2.0-no_aop.jar:/home/ggastald/.m2/repository/aopalliance/aopalliance/1.0/aopalliance-1.0.jar:/home/ggastald/.m2/repository/com/google/guava/guava/27.0.1-jre/guava-27.0.1-jre.jar:/home/ggastald/.m2/repository/com/google/guava/failureaccess/1.0.1/failureaccess-1.0.1.jar:/home/ggastald/.m2/repository/com/google/guava/listenablefuture/9999.0-empty-to-avoid-conflict-with-guava/listenablefuture-9999.0-empty-to-avoid-conflict-with-guava.jar:/home/ggastald/.m2/repository/com/google/code/findbugs/jsr305/3.0.2/jsr305-3.0.2.jar:/home/ggastald/.m2/repository/com/google/j2objc/j2objc-annotations/1.1/j2objc-annotations-1.1.jar:/home/ggastald/.m2/repository/org/codehaus/mojo/animal-sniffer-annotations/1.17/animal-sniffer-annotations-1.17.jar:/home/ggastald/.m2/repository/org/codehaus/plexus/plexus-utils/3.0.24/plexus-utils-3.0.24.jar:/home/ggastald/.m2/repository/org/codehaus/plexus/plexus-classworlds/2.5.2/plexus-classworlds-2.5.2.jar:/home/ggastald/.m2/repository/org/eclipse/sisu/org.eclipse.sisu.plexus/0.3.3/org.eclipse.sisu.plexus-0.3.3.jar:/home/ggastald/.m2/repository/org/codehaus/plexus/plexus-component-annotations/1.7.1/plexus-component-annotations-1.7.1.jar:/home/ggastald/.m2/repository/commons-cli/commons-cli/1.4/commons-cli-1.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-settings-builder/3.5.4/maven-settings-builder-3.5.4.jar:/home/ggastald/.m2/repository/org/codehaus/plexus/plexus-interpolation/1.24/plexus-interpolation-1.24.jar:/home/ggastald/.m2/repository/org/sonatype/plexus/plexus-sec-dispatcher/1.4/plexus-sec-dispatcher-1.4.jar:/home/ggastald/.m2/repository/org/sonatype/plexus/plexus-cipher/1.4/plexus-cipher-1.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-resolver-provider/3.5.4/maven-resolver-provider-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/maven-repository-metadata/3.5.4/maven-repository-metadata-3.5.4.jar:/home/ggastald/.m2/repository/org/apache/maven/resolver/maven-resolver-spi/1.1.1/maven-resolver-spi-1.1.1.jar:/home/ggastald/.m2/repository/org/apache/maven/resolver/maven-resolver-impl/1.1.1/maven-resolver-impl-1.1.1.jar:/home/ggastald/.m2/repository/org/apache/maven/resolver/maven-resolver-connector-basic/1.1.1/maven-resolver-connector-basic-1.1.1.jar:/home/ggastald/.m2/repository/org/apache/maven/resolver/maven-resolver-transport-wagon/1.1.1/maven-resolver-transport-wagon-1.1.1.jar:/home/ggastald/.m2/repository/org/apache/maven/wagon/wagon-provider-api/3.0.0/wagon-provider-api-3.0.0.jar:/home/ggastald/.m2/repository/org/apache/maven/wagon/wagon-http/3.0.0/wagon-http-3.0.0.jar:/home/ggastald/.m2/repository/org/apache/maven/wagon/wagon-http-shared/3.0.0/wagon-http-shared-3.0.0.jar:/home/ggastald/.m2/repository/org/jsoup/jsoup/1.7.2/jsoup-1.7.2.jar:/home/ggastald/.m2/repository/org/apache/maven/wagon/wagon-file/3.0.0/wagon-file-3.0.0.jar:/home/ggastald/.m2/repository/org/jboss/logging/commons-logging-jboss-logging/1.0.0.Final/commons-logging-jboss-logging-1.0.0.Final.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-test-common/999-SNAPSHOT/quarkus-test-common-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-core-deployment/999-SNAPSHOT/quarkus-core-deployment-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/gizmo/gizmo/1.0.2.Final/gizmo-1.0.2.Final.jar:/home/ggastald/.m2/repository/org/ow2/asm/asm-util/7.3.1/asm-util-7.3.1.jar:/home/ggastald/.m2/repository/org/ow2/asm/asm-tree/7.3.1/asm-tree-7.3.1.jar:/home/ggastald/.m2/repository/org/ow2/asm/asm-analysis/7.3.1/asm-analysis-7.3.1.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-builder/999-SNAPSHOT/quarkus-builder-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/io/quarkus/quarkus-jsonp-deployment/999-SNAPSHOT/quarkus-jsonp-deployment-999-SNAPSHOT.jar:/home/ggastald/.m2/repository/org/junit/jupiter/junit-jupiter/5.6.0/junit-jupiter-5.6.0.jar:/home/ggastald/.m2/repository/org/junit/jupiter/junit-jupiter-api/5.6.0/junit-jupiter-api-5.6.0.jar:/home/ggastald/.m2/repository/org/apiguardian/apiguardian-api/1.1.0/apiguardian-api-1.1.0.jar:/home/ggastald/.m2/repository/org/opentest4j/opentest4j/1.2.0/opentest4j-1.2.0.jar:/home/ggastald/.m2/repository/org/junit/platform/junit-platform-commons/1.6.0/junit-platform-commons-1.6.0.jar:/home/ggastald/.m2/repository/org/junit/jupiter/junit-jupiter-params/5.6.0/junit-jupiter-params-5.6.0.jar:/home/ggastald/.m2/repository/org/junit/jupiter/junit-jupiter-engine/5.6.0/junit-jupiter-engine-5.6.0.jar:/home/ggastald/.m2/repository/org/junit/platform/junit-platform-engine/1.6.0/junit-platform-engine-1.6.0.jar:/home/ggastald/.m2/repository/io/rest-assured/rest-assured/4.2.0/rest-assured-4.2.0.jar:/home/ggastald/.m2/repository/org/codehaus/groovy/groovy/2.5.8/groovy-2.5.8.jar:/home/ggastald/.m2/repository/org/codehaus/groovy/groovy-xml/2.5.8/groovy-xml-2.5.8.jar:/home/ggastald/.m2/repository/org/apache/httpcomponents/httpclient/4.5.11/httpclient-4.5.11.jar:/home/ggastald/.m2/repository/org/apache/httpcomponents/httpcore/4.4.13/httpcore-4.4.13.jar:/home/ggastald/.m2/repository/commons-codec/commons-codec/1.13/commons-codec-1.13.jar:/home/ggastald/.m2/repository/org/apache/httpcomponents/httpmime/4.5.3/httpmime-4.5.3.jar:/home/ggastald/.m2/repository/org/hamcrest/hamcrest/2.1/hamcrest-2.1.jar:/home/ggastald/.m2/repository/org/ccil/cowan/tagsoup/tagsoup/1.2.1/tagsoup-1.2.1.jar:/home/ggastald/.m2/repository/io/rest-assured/json-path/4.2.0/json-path-4.2.0.jar:/home/ggastald/.m2/repository/org/codehaus/groovy/groovy-json/2.5.8/groovy-json-2.5.8.jar:/home/ggastald/.m2/repository/io/rest-assured/rest-assured-common/4.2.0/rest-assured-common-4.2.0.jar:/home/ggastald/.m2/repository/io/rest-assured/xml-path/4.2.0/xml-path-4.2.0.jar:/home/ggastald/.m2/repository/org/apache/commons/commons-lang3/3.9/commons-lang3-3.9.jar:/home/ggastald/.m2/repository/jakarta/xml/bind/jakarta.xml.bind-api/2.3.2/jakarta.xml.bind-api-2.3.2.jar:/home/ggastald/.m2/repository/jakarta/activation/jakarta.activation-api/1.2.1/jakarta.activation-api-1.2.1.jar:/home/ggastald/.m2/repository/org/apache/sling/org.apache.sling.javax.activation/0.1.0/org.apache.sling.javax.activation-0.1.0.jar:/home/ggastald/.m2/repository/org/junit/platform/junit-platform-launcher/1.6.0/junit-platform-launcher-1.6.0.jar com.intellij.rt.junit.JUnitStarter -ideVersion5 -junit5 org.acme.hibernate.orm.FruitsEndpointTest
Feb 21, 2020 9:13:05 AM org.jboss.threads.Version <clinit>
INFO: JBoss Threads version 3.0.1.Final
Feb 21, 2020 9:13:05 AM org.hibernate.Version logVersion
INFO: HHH000412: Hibernate ORM core version 5.4.12.Final
Feb 21, 2020 9:13:06 AM org.hibernate.jpa.internal.util.LogHelper logPersistenceUnitInformation
INFO: HHH000204: Processing PersistenceUnitInfo [name: default]
Feb 21, 2020 9:13:06 AM org.hibernate.Version logVersion
INFO: HHH000412: Hibernate ORM core version 5.4.12.Final
Feb 21, 2020 9:13:06 AM org.hibernate.annotations.common.reflection.java.JavaReflectionManager <clinit>
INFO: HCANN000001: Hibernate Commons Annotations {5.1.0.Final}
Feb 21, 2020 9:13:06 AM org.hibernate.dialect.Dialect <init>
INFO: HHH000400: Using dialect: io.quarkus.hibernate.orm.runtime.dialect.QuarkusH2Dialect
Feb 21, 2020 9:13:07 AM org.jboss.threads.Version <clinit>
INFO: JBoss Threads version 3.0.1.Final
Feb 21, 2020 9:13:07 AM org.hibernate.resource.beans.spi.ManagedBeanRegistryInitiator resolveBeanContainer
INFO: HHH10005002: No explicit CDI BeanManager reference was passed to Hibernate, but CDI is available on the Hibernate ClassLoader.
Feb 21, 2020 9:13:07 AM io.quarkus.agroal.runtime.AgroalEventLoggingListener onInfo
INFO: Datasource '<default>': Initial size smaller than min. Connections will be created when necessary
Hibernate: 

    drop table known_fruits if exists
Hibernate: 

    drop sequence if exists known_fruits_id_seq
Hibernate: create sequence known_fruits_id_seq start with 10 increment by 1
Hibernate: 

    create table known_fruits (
       id integer not null,
        name varchar(40),
        primary key (id)
    )
Hibernate: 

    alter table known_fruits 
       add constraint UK_57g3m8wr3qxoj706a6hsqg6ye unique (name)
Feb 21, 2020 9:13:07 AM org.hibernate.tool.schema.internal.exec.AbstractScriptSourceInput prepare
INFO: HHH000476: Executing import script 'file:/home/ggastald/workspace/quarkus-quickstarts/hibernate-orm-quickstart/target/classes/import.sql'
Hibernate: 
    INSERT INTO known_fruits(id, name) VALUES (1, 'Cherry')
Hibernate: 
    INSERT INTO known_fruits(id, name) VALUES (2, 'Apple')
Hibernate: 
    INSERT INTO known_fruits(id, name) VALUES (3, 'Banana')
Feb 21, 2020 9:13:07 AM io.quarkus.runtime.Timing printStartupTime
INFO: Quarkus 999-SNAPSHOT started in 3.384s. Listening on: http://0.0.0.0:8081
Feb 21, 2020 9:13:07 AM io.quarkus.runtime.Timing printStartupTime
INFO: Profile test activated. 
Feb 21, 2020 9:13:07 AM io.quarkus.runtime.Timing printStartupTime
INFO: Installed features: [agroal, cdi, hibernate-orm, jdbc-h2, narayana-jta, resteasy, resteasy-jsonb]

Hibernate: 
    select
        fruit0_.id as id1_0_,
        fruit0_.name as name2_0_ 
    from
        known_fruits fruit0_ 
    order by
        fruit0_.name
Hibernate: 
    select
        fruit0_.id as id1_0_0_,
        fruit0_.name as name2_0_0_ 
    from
        known_fruits fruit0_ 
    where
        fruit0_.id=?
Hibernate: 
    delete 
    from
        known_fruits 
    where
        id=?
Hibernate: 
    select
        fruit0_.id as id1_0_,
        fruit0_.name as name2_0_ 
    from
        known_fruits fruit0_ 
    order by
        fruit0_.name
Hibernate: 
    call next value for known_fruits_id_seq
Hibernate: 
    insert 
    into
        known_fruits
        (name, id) 
    values
        (?, ?)
Hibernate: 
    select
        fruit0_.id as id1_0_,
        fruit0_.name as name2_0_ 
    from
        known_fruits fruit0_ 
    order by
        fruit0_.name

Feb 21, 2020 9:13:09 AM io.quarkus.runtime.Timing printStopTime
INFO: Quarkus stopped in 0.031s

Process finished with exit code 0
ge0ffrey commented 4 years ago

@gastaldi (no reproduction) and me (reproduction) seem to use the exact same IntelliJ Ultimate version (193.6494.35) now.

geoand commented 4 years ago

And my IntelliJ version (just for the record, I can't reproduce either):

IntelliJ IDEA 2019.3.3 (Ultimate Edition)
Build #IU-193.6494.35, built on February 11, 2020

@ge0ffrey do you perhaps have any Quarkus IntelliJ plugins?

ge0ffrey commented 4 years ago

Nope, only 2 non-bundled IntelliJ plugins (asciidoc and CSV plugin)

ge0ffrey commented 4 years ago

I can reproduce it on every quickstart, including the rest-json-quickstart LegumeResourceTest - so which no special H2 changes etc.

gastaldi commented 4 years ago

What's shown when you execute jstack <pid> with the hanging process?

ge0ffrey commented 4 years ago

Same as in IntelliJ thread dump that is in the zulip chat, fwiw.

And it is somehow forever-locked on trying to system.out/err the InvocationTargetException that occurs (which I discovered by debugging during this stacktrace).

Full thread dump OpenJDK 64-Bit Server VM (25.191-b12 mixed mode):

"Attach Listener" #12 daemon prio=9 os_prio=0 tid=0x00007fc344001000 nid=0x2d47 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Monitor Ctrl-Break" #10 daemon prio=5 os_prio=0 tid=0x00007fc3a0172000 nid=0x2d3b runnable [0x00007fc3787c5000]
   java.lang.Thread.State: RUNNABLE
        at java.net.SocketInputStream.socketRead0(Native Method)
        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
        at java.net.SocketInputStream.read(SocketInputStream.java:171)
        at java.net.SocketInputStream.read(SocketInputStream.java:141)
        at sun.nio.cs.StreamDecoder.readBytes(StreamDecoder.java:284)
        at sun.nio.cs.StreamDecoder.implRead(StreamDecoder.java:326)
        at sun.nio.cs.StreamDecoder.read(StreamDecoder.java:178)
        - locked <0x00000005cee565c0> (a java.io.InputStreamReader)
        at java.io.InputStreamReader.read(InputStreamReader.java:184)
        at java.io.BufferedReader.fill(BufferedReader.java:161)
        at java.io.BufferedReader.readLine(BufferedReader.java:324)
        - locked <0x00000005cee565c0> (a java.io.InputStreamReader)
        at java.io.BufferedReader.readLine(BufferedReader.java:389)
        at com.intellij.rt.execution.application.AppMainV2$1.run(AppMainV2.java:64)

"Service Thread" #9 daemon prio=9 os_prio=0 tid=0x00007fc3a0137800 nid=0x2d39 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C1 CompilerThread3" #8 daemon prio=9 os_prio=0 tid=0x00007fc3a0134800 nid=0x2d38 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread2" #7 daemon prio=9 os_prio=0 tid=0x00007fc3a0132800 nid=0x2d37 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread1" #6 daemon prio=9 os_prio=0 tid=0x00007fc3a0131000 nid=0x2d36 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"C2 CompilerThread0" #5 daemon prio=9 os_prio=0 tid=0x00007fc3a012e000 nid=0x2d35 waiting on condition [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Signal Dispatcher" #4 daemon prio=9 os_prio=0 tid=0x00007fc3a0121800 nid=0x2d34 runnable [0x0000000000000000]
   java.lang.Thread.State: RUNNABLE

"Finalizer" #3 daemon prio=8 os_prio=0 tid=0x00007fc3a00f4800 nid=0x2d32 in Object.wait() [0x00007fc378fcd000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(Native Method)
        - waiting on <0x00000005ce4ad160> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:144)
        - locked <0x00000005ce4ad160> (a java.lang.ref.ReferenceQueue$Lock)
        at java.lang.ref.ReferenceQueue.remove(ReferenceQueue.java:165)
        at java.lang.ref.Finalizer$FinalizerThread.run(Finalizer.java:216)

"Reference Handler" #2 daemon prio=10 os_prio=0 tid=0x00007fc3a00ef800 nid=0x2d31 in Object.wait() [0x00007fc3790ce000]
   java.lang.Thread.State: WAITING (on object monitor)
        at java.lang.Object.wait(Native Method)
        - waiting on <0x00000005cee572d0> (a java.lang.ref.Reference$Lock)
        at java.lang.Object.wait(Object.java:502)
        at java.lang.ref.Reference.tryHandlePending(Reference.java:191)
        - locked <0x00000005cee572d0> (a java.lang.ref.Reference$Lock)
        at java.lang.ref.Reference$ReferenceHandler.run(Reference.java:153)

"main" #1 prio=5 os_prio=0 tid=0x00007fc3a0054800 nid=0x2d20 runnable [0x00007fc3a90a5000]
   java.lang.Thread.State: RUNNABLE
        at java.io.FileOutputStream.writeBytes(Native Method)
        at java.io.FileOutputStream.write(FileOutputStream.java:326)
        at java.io.BufferedOutputStream.write(BufferedOutputStream.java:122)
        - locked <0x00000005ce3ebdf8> (a java.io.BufferedOutputStream)
        at java.io.PrintStream.write(PrintStream.java:480)
        - locked <0x00000005ce3ebdd8> (a java.io.PrintStream)
        at sun.nio.cs.StreamEncoder.writeBytes(StreamEncoder.java:221)
        at sun.nio.cs.StreamEncoder.implWrite(StreamEncoder.java:282)
        at sun.nio.cs.StreamEncoder.write(StreamEncoder.java:125)
        - locked <0x00000005ce3ebf18> (a java.io.OutputStreamWriter)
        at java.io.OutputStreamWriter.write(OutputStreamWriter.java:207)
        at java.io.BufferedWriter.flushBuffer(BufferedWriter.java:129)
        - locked <0x00000005ce3ebf18> (a java.io.OutputStreamWriter)
        at java.io.BufferedWriter.write(BufferedWriter.java:230)
        - locked <0x00000005ce3ebf18> (a java.io.OutputStreamWriter)
        at java.io.Writer.write(Writer.java:157)
        at java.io.PrintStream.write(PrintStream.java:525)
        - locked <0x00000005ce3ebdd8> (a java.io.PrintStream)
        at java.io.PrintStream.print(PrintStream.java:669)
        at java.io.PrintStream.println(PrintStream.java:806)
        - locked <0x00000005ce3ebdd8> (a java.io.PrintStream)
        at com.intellij.junit5.JUnit5TestExecutionListener.testFailure(JUnit5TestExecutionListener.java:298)
        at com.intellij.junit5.JUnit5TestExecutionListener.testFailure(JUnit5TestExecutionListener.java:246)
        at com.intellij.junit5.JUnit5TestExecutionListener.executionFinished(JUnit5TestExecutionListener.java:184)
        at com.intellij.junit5.JUnit5TestExecutionListener.executionFinished(JUnit5TestExecutionListener.java:172)
        at org.junit.platform.launcher.core.TestExecutionListenerRegistry$CompositeTestExecutionListener.lambda$executionFinished$10(TestExecutionListenerRegistry.java:109)
        at org.junit.platform.launcher.core.TestExecutionListenerRegistry$CompositeTestExecutionListener$$Lambda$368/1573751930.accept(Unknown Source)
        at org.junit.platform.launcher.core.TestExecutionListenerRegistry.lambda$notifyEach$1(TestExecutionListenerRegistry.java:67)
        at org.junit.platform.launcher.core.TestExecutionListenerRegistry$$Lambda$142/731260860.accept(Unknown Source)
        at java.util.ArrayList.forEach(ArrayList.java:1257)
        at org.junit.platform.launcher.core.TestExecutionListenerRegistry.notifyEach(TestExecutionListenerRegistry.java:65)
        at org.junit.platform.launcher.core.TestExecutionListenerRegistry.access$200(TestExecutionListenerRegistry.java:32)
        at org.junit.platform.launcher.core.TestExecutionListenerRegistry$CompositeTestExecutionListener.executionFinished(TestExecutionListenerRegistry.java:108)
        at org.junit.platform.launcher.core.ExecutionListenerAdapter.executionFinished(ExecutionListenerAdapter.java:56)
        at org.junit.platform.launcher.core.DelegatingEngineExecutionListener.executionFinished(DelegatingEngineExecutionListener.java:46)
        at org.junit.platform.launcher.core.OutcomeDelayingEngineExecutionListener.executionFinished(OutcomeDelayingEngineExecutionListener.java:63)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.reportCompletion(NodeTestTask.java:179)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:85)
        at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService$$Lambda$183/699780352.accept(Unknown Source)
        at java.util.ArrayList.forEach(ArrayList.java:1257)
        at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$179/601008104.execute(Unknown Source)
        at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$178/1752203484.invoke(Unknown Source)
        at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$177/1489069835.execute(Unknown Source)
        at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
        at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService$$Lambda$183/699780352.accept(Unknown Source)
        at java.util.ArrayList.forEach(ArrayList.java:1257)
        at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$179/601008104.execute(Unknown Source)
        at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$178/1752203484.invoke(Unknown Source)
        at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask$$Lambda$177/1489069835.execute(Unknown Source)
        at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
        at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
        at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:32)
        at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
        at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:51)
        at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:248)
        at org.junit.platform.launcher.core.DefaultLauncher.lambda$execute$5(DefaultLauncher.java:211)
        at org.junit.platform.launcher.core.DefaultLauncher$$Lambda$137/553871028.accept(Unknown Source)
        at org.junit.platform.launcher.core.DefaultLauncher.withInterceptedStreams(DefaultLauncher.java:226)
        at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:199)
        at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:132)
        at com.intellij.junit5.JUnit5IdeaTestRunner.startRunnerWithArgs(JUnit5IdeaTestRunner.java:69)
        at com.intellij.rt.junit.IdeaTestRunner$Repeater.startRunnerWithArgs(IdeaTestRunner.java:33)
        at com.intellij.rt.junit.JUnitStarter.prepareStreamsAndStart(JUnitStarter.java:230)
        at com.intellij.rt.junit.JUnitStarter.main(JUnitStarter.java:58)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at com.intellij.rt.execution.application.AppMainV2.main(AppMainV2.java:131)

"VM Thread" os_prio=0 tid=0x00007fc3a00e6000 nid=0x2d2d runnable 

"GC task thread#0 (ParallelGC)" os_prio=0 tid=0x00007fc3a0067000 nid=0x2d21 runnable 

"GC task thread#1 (ParallelGC)" os_prio=0 tid=0x00007fc3a0069000 nid=0x2d22 runnable 

"GC task thread#2 (ParallelGC)" os_prio=0 tid=0x00007fc3a006a800 nid=0x2d23 runnable 

"GC task thread#3 (ParallelGC)" os_prio=0 tid=0x00007fc3a006c800 nid=0x2d24 runnable 

"GC task thread#4 (ParallelGC)" os_prio=0 tid=0x00007fc3a006e000 nid=0x2d25 runnable 

"GC task thread#5 (ParallelGC)" os_prio=0 tid=0x00007fc3a0070000 nid=0x2d26 runnable 

"GC task thread#6 (ParallelGC)" os_prio=0 tid=0x00007fc3a0071800 nid=0x2d27 runnable 

"GC task thread#7 (ParallelGC)" os_prio=0 tid=0x00007fc3a0073800 nid=0x2d28 runnable 

"VM Periodic Task Thread" os_prio=0 tid=0x00007fc3a013a000 nid=0x2d3a waiting on condition 

JNI global references: 866
ge0ffrey commented 4 years ago

This is the exception it's trying to log:

image

That 2th stacktrace points to this code:

public static String getUri(RunningQuarkusApplication application) {
        return application.getConfigValue("test.url", String.class).get();
    }

which calls

return (Optional<T>) getConfig.getReturnType().getMethod("getOptionalValue", String.class, Class.class)
                    .invoke(config, key, type);
ge0ffrey commented 4 years ago

My team member Musa just tried to reproduce without success. It's really just my machine apparently. Restarting IntelliJ didn't work, let me restart my entire machine.

geoand commented 4 years ago

Thanks for being so thorough about this!

ge0ffrey commented 4 years ago

My team member Musa just tried to reproduce without success. It's really just my machine apparently. Restarting IntelliJ didn't work. Restarting my entire machine didn't work either. Tests in other projects work fine. It's just quarkus-quickstart tests.

MusaTalluzi commented 4 years ago

I can't reproduce it either, here's my IntelliJ version:

IntelliJ IDEA 2019.2.2 (Ultimate Edition)
Build #IU-192.6603.28, built on September 6, 2019

And the output of running FruitsEndpointTest following the instructions:

Feb 21, 2020 12:08:00 PM org.jboss.threads.Version <clinit>
INFO: JBoss Threads version 3.0.1.Final
Feb 21, 2020 12:08:01 PM org.hibernate.Version logVersion
INFO: HHH000412: Hibernate ORM core version 5.4.12.Final
Feb 21, 2020 12:08:01 PM org.hibernate.jpa.internal.util.LogHelper logPersistenceUnitInformation
INFO: HHH000204: Processing PersistenceUnitInfo [name: default]
Feb 21, 2020 12:08:01 PM org.hibernate.Version logVersion
INFO: HHH000412: Hibernate ORM core version 5.4.12.Final
Feb 21, 2020 12:08:01 PM org.hibernate.annotations.common.reflection.java.JavaReflectionManager <clinit>
INFO: HCANN000001: Hibernate Commons Annotations {5.1.0.Final}
Feb 21, 2020 12:08:01 PM org.hibernate.dialect.Dialect <init>
INFO: HHH000400: Using dialect: io.quarkus.hibernate.orm.runtime.dialect.QuarkusH2Dialect
Feb 21, 2020 12:08:02 PM org.jboss.threads.Version <clinit>
INFO: JBoss Threads version 3.0.1.Final
Feb 21, 2020 12:08:02 PM org.hibernate.resource.beans.spi.ManagedBeanRegistryInitiator resolveBeanContainer
INFO: HHH10005002: No explicit CDI BeanManager reference was passed to Hibernate, but CDI is available on the Hibernate ClassLoader.
Feb 21, 2020 12:08:03 PM io.quarkus.agroal.runtime.AgroalEventLoggingListener onInfo
INFO: Datasource '<default>': Initial size smaller than min. Connections will be created when necessary
Hibernate: 

    drop table known_fruits if exists
Hibernate: 

    drop sequence if exists known_fruits_id_seq
Hibernate: create sequence known_fruits_id_seq start with 10 increment by 1
Hibernate: 

    create table known_fruits (
       id integer not null,
        name varchar(40),
        primary key (id)
    )
Hibernate: 

    alter table known_fruits 
       add constraint UK_57g3m8wr3qxoj706a6hsqg6ye unique (name)
Feb 21, 2020 12:08:03 PM org.hibernate.tool.schema.internal.exec.AbstractScriptSourceInput prepare
INFO: HHH000476: Executing import script 'file:/home/internx1/projects/kiegroup/quarkus-quickstarts/hibernate-orm-quickstart/target/classes/import.sql'
Hibernate: 
    INSERT INTO known_fruits(id, name) VALUES (1, 'Cherry')
Hibernate: 
    INSERT INTO known_fruits(id, name) VALUES (2, 'Apple')
Hibernate: 
    INSERT INTO known_fruits(id, name) VALUES (3, 'Banana')
Feb 21, 2020 12:08:03 PM io.quarkus.runtime.Timing printStartupTime
INFO: Quarkus 999-SNAPSHOT started in 3.578s. Listening on: http://0.0.0.0:8081
Feb 21, 2020 12:08:03 PM io.quarkus.runtime.Timing printStartupTime
INFO: Profile test activated. 
Feb 21, 2020 12:08:03 PM io.quarkus.runtime.Timing printStartupTime
INFO: Installed features: [agroal, cdi, hibernate-orm, jdbc-h2, narayana-jta, resteasy, resteasy-jsonb]

Hibernate: 
    select
        fruit0_.id as id1_0_,
        fruit0_.name as name2_0_ 
    from
        known_fruits fruit0_ 
    order by
        fruit0_.name
Hibernate: 
    select
        fruit0_.id as id1_0_0_,
        fruit0_.name as name2_0_0_ 
    from
        known_fruits fruit0_ 
    where
        fruit0_.id=?
Hibernate: 
    delete 
    from
        known_fruits 
    where
        id=?
Hibernate: 
    select
        fruit0_.id as id1_0_,
        fruit0_.name as name2_0_ 
    from
        known_fruits fruit0_ 
    order by
        fruit0_.name
Hibernate: 
    call next value for known_fruits_id_seq
Hibernate: 
    insert 
    into
        known_fruits
        (name, id) 
    values
        (?, ?)
Hibernate: 
    select
        fruit0_.id as id1_0_,
        fruit0_.name as name2_0_ 
    from
        known_fruits fruit0_ 
    order by
        fruit0_.name

Feb 21, 2020 12:08:05 PM io.quarkus.runtime.Timing printStopTime
INFO: Quarkus stopped in 0.032s

Process finished with exit code 0
jaikiran commented 4 years ago

Hello @ge0ffrey, which OS are you on and what Java vendor and version does this JVM correspond to:

Full thread dump OpenJDK 64-Bit Server VM (25.191-b12 mixed mode)
jaikiran commented 4 years ago

@ge0ffrey - would you be able to pass (via IntelliJ test launch configs) the system property junit.platform.discovery.listener.default with its value set to logging and see if it makes a difference?

ge0ffrey commented 4 years ago

I checked out quarkus-quickstarts again (I call my 2nd checkout old-quarkus-quickstarts). There it does NOT reproduce. The IntelliJ run configuration is exactly the same. Rebooting my computer didn't help: the original checkout still reproduces every time.

geoand commented 4 years ago

@ge0ffrey can you perphaps do a diff of the command command that IntelliJ runs in both cases and see if there is any difference worth noting?

ge0ffrey commented 4 years ago

Zipping my local checkout and mailing that to Georgios (= same .idea folder etc) did not reproduce it there.

stuartwdouglas commented 4 years ago

It am going to close this, given that it could only be reproduced on one machine with a specific checkout I don't think we will get to the bottom of it unless it pops up again.

ge0ffrey commented 4 years ago

I've not seen this issue since, I forget if we found the cause or not, but it doesn't reproduce any more. Thanks for closing it.