michaeljmarshall commented on PR #17754:
URL: https://github.com/apache/pulsar/pull/17754#issuecomment-1281766534

   The sql step is failing with the following error: 
   
   ```
     2022-10-17T22:09:52,280 - INFO  - 
[docker-java-stream-913315710:DockerUtils$4@383] - 
DOCKER.exec(pulsar-sql-test-pulsar-broker-0:tail -f 
/var/log/pulsar/broker.log): STDOUT: 2022-10-17T22:09:51,968+0000 
[pulsar-load-manager-1-1] INFO  
org.apache.pulsar.broker.loadbalance.impl.ModularLoadManagerImpl - Only 1 
broker available: no load shedding will be performed
     2022-10-17T22:10:01,090 - ERROR - [main:GenericContainer@524] - Could not 
start container
     org.testcontainers.containers.ContainerLaunchException: Timed out waiting 
for URL to be accessible (http://localhost:49162/v1/info/state should return 
HTTP [200])
        at 
org.testcontainers.containers.wait.strategy.HttpWaitStrategy.waitUntilReady(HttpWaitStrategy.java:286)
 ~[testcontainers-1.17.2.jar:?]
        at 
org.testcontainers.containers.wait.strategy.AbstractWaitStrategy.waitUntilReady(AbstractWaitStrategy.java:51)
 ~[testcontainers-1.17.2.jar:?]
        at 
org.testcontainers.containers.GenericContainer.waitUntilContainerStarted(GenericContainer.java:926)
 ~[testcontainers-1.17.2.jar:?]
        at 
org.testcontainers.containers.GenericContainer.tryStart(GenericContainer.java:480)
 ~[testcontainers-1.17.2.jar:?]
        at 
org.testcontainers.containers.GenericContainer.lambda$doStart$0(GenericContainer.java:340)
 ~[testcontainers-1.17.2.jar:?]
        at 
org.rnorth.ducttape.unreliables.Unreliables.retryUntilSuccess(Unreliables.java:81)
 ~[duct-tape-1.0.8.jar:?]
        at 
org.testcontainers.containers.GenericContainer.doStart(GenericContainer.java:338)
 ~[testcontainers-1.17.2.jar:?]
        at 
org.testcontainers.containers.GenericContainer.start(GenericContainer.java:326) 
~[testcontainers-1.17.2.jar:?]
        at 
org.apache.pulsar.tests.integration.containers.PulsarContainer.start(PulsarContainer.java:182)
 ~[test-classes/:?]
        at 
org.apache.pulsar.tests.integration.topologies.PulsarCluster.startPrestoWorker(PulsarCluster.java:393)
 ~[test-classes/:?]
        at 
org.apache.pulsar.tests.integration.topologies.PulsarCluster.startPrestoWorker(PulsarCluster.java:384)
 ~[test-classes/:?]
        at 
org.apache.pulsar.tests.integration.presto.TestBasicPresto.setupPresto(TestBasicPresto.java:58)
 ~[test-classes/:?]
        at 
org.apache.pulsar.tests.integration.presto.TestBasicPresto.setupCluster(TestBasicPresto.java:70)
 ~[test-classes/:?]
        at 
org.apache.pulsar.tests.integration.topologies.PulsarClusterTestBase.setup(PulsarClusterTestBase.java:42)
 ~[test-classes/:?]
        at 
org.apache.pulsar.tests.integration.suites.PulsarTestSuite.setupBeforeClass(PulsarTestSuite.java:30)
 ~[test-classes/:?]
        at jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) 
~[?:?]
        at 
jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
 ~[?:?]
        at 
jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
 ~[?:?]
        at java.lang.reflect.Method.invoke(Method.java:568) ~[?:?]
        at 
org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:132)
 ~[testng-7.3.0.jar:?]
        at 
org.testng.internal.MethodInvocationHelper.invokeMethodConsideringTimeout(MethodInvocationHelper.java:61)
 ~[testng-7.3.0.jar:?]
        at 
org.testng.internal.ConfigInvoker.invokeConfigurationMethod(ConfigInvoker.java:366)
 ~[testng-7.3.0.jar:?]
        at 
org.testng.internal.ConfigInvoker.invokeConfigurations(ConfigInvoker.java:320) 
~[testng-7.3.0.jar:?]
        at 
org.testng.internal.TestMethodWorker.invokeBeforeClassMethods(TestMethodWorker.java:176)
 ~[testng-7.3.0.jar:?]
        at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:122) 
~[testng-7.3.0.jar:?]
        at java.util.ArrayList.forEach(ArrayList.java:1511) ~[?:?]
        at org.testng.TestRunner.privateRun(TestRunner.java:764) 
~[testng-7.3.0.jar:?]
        at org.testng.TestRunner.run(TestRunner.java:585) ~[testng-7.3.0.jar:?]
        at org.testng.SuiteRunner.runTest(SuiteRunner.java:384) 
~[testng-7.3.0.jar:?]
        at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:378) 
~[testng-7.3.0.jar:?]
        at org.testng.SuiteRunner.privateRun(SuiteRunner.java:337) 
~[testng-7.3.0.jar:?]
        at org.testng.SuiteRunner.run(SuiteRunner.java:286) 
~[testng-7.3.0.jar:?]
        at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:53) 
~[testng-7.3.0.jar:?]
        at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:96) 
~[testng-7.3.0.jar:?]
        at org.testng.TestNG.runSuitesSequentially(TestNG.java:1218) 
~[testng-7.3.0.jar:?]
        at org.testng.TestNG.runSuitesLocally(TestNG.java:1140) 
~[testng-7.3.0.jar:?]
        at org.testng.TestNG.runSuites(TestNG.java:1069) ~[testng-7.3.0.jar:?]
        at org.testng.TestNG.run(TestNG.java:1037) ~[testng-7.3.0.jar:?]
        at 
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283) 
~[surefire-testng-3.0.0-M3.jar:3.0.0-M3]
        at 
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
 ~[surefire-testng-3.0.0-M3.jar:3.0.0-M3]
        at 
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120) 
~[surefire-testng-3.0.0-M3.jar:3.0.0-M3]
        at 
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
 ~[surefire-booter-3.0.0-M3.jar:3.0.0-M3]
        at 
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
 ~[surefire-booter-3.0.0-M3.jar:3.0.0-M3]
        at 
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126) 
~[surefire-booter-3.0.0-M3.jar:3.0.0-M3]
        at 
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418) 
~[surefire-booter-3.0.0-M3.jar:3.0.0-M3]
     2022-10-17T22:10:01,124 - ERROR - [main:GenericContainer@531] - Log output 
from the failed container:
     [trino/conf/catalog/pulsar.properties] Applying config 
pulsar.bookkeeper-explicit-interval = 10
     [trino/conf/catalog/pulsar.properties] Applying config 
pulsar.bookkeeper-use-v2-protocol = false
     [trino/conf/catalog/pulsar.properties] Applying config 
pulsar.web-service-url = http://pulsar-broker-0:8080
     [trino/conf/catalog/pulsar.properties] Applying config 
pulsar.zookeeper-uri = zookeeper:2181
     [trino/conf/catalog/pulsar.properties] Adding config 
pulsar.max-message-size = 10485760
     2022-10-17 22:05:01,446 CRIT Supervisor is running as root.  Privileges 
were not dropped because no user is specified in the config file.  If you 
intend to run as root, you can set user=root in the config file to avoid this 
message.
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/bookie.conf" during parsing
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/broker.conf" during parsing
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/functions_worker.conf" during parsing
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/global-zk.conf" during parsing
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/local-zk.conf" during parsing
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/presto_worker.conf" during parsing
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/proxy.conf" during parsing
     2022-10-17 22:05:01,448 INFO Included extra file 
"/etc/supervisord/conf.d/websocket.conf" during parsing
     2022-10-17 22:05:01,455 INFO RPC interface 'supervisor' initialized
     2022-10-17 22:05:01,455 CRIT Server 'unix_http_server' running without any 
HTTP authentication checking
     2022-10-17 22:05:01,456 INFO supervisord started with pid 1
     2022-10-17 22:05:02,459 INFO spawned: 'presto-worker' with pid 17
     2022-10-17 22:05:02,673 INFO exited: presto-worker (exit status 4; not 
expected)
     2022-10-17 22:05:03,676 INFO spawned: 'presto-worker' with pid 93
     2022-10-17 22:05:03,886 INFO exited: presto-worker (exit status 4; not 
expected)
     2022-10-17 22:05:05,890 INFO spawned: 'presto-worker' with pid 169
     2022-10-17 22:05:06,098 INFO exited: presto-worker (exit status 4; not 
expected)
     2022-10-17 22:05:09,105 INFO spawned: 'presto-worker' with pid 245
     2022-10-17 22:05:09,308 INFO exited: presto-worker (exit status 4; not 
expected)
     2022-10-17 22:05:10,310 INFO gave up: presto-worker entered FATAL state, 
too many start retries too quickly
   ```
   
   @lhotari - have you seen this exit status 4 before? It seems like it would 
be a flaky issue, but I seem to be consistently failing at the sql job.


-- 
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.

To unsubscribe, e-mail: [email protected]

For queries about this service, please contact Infrastructure at:
[email protected]

Reply via email to