Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

set timeout of raft api test to 60s #1738

Merged
merged 3 commits into from
Feb 21, 2022
Merged

set timeout of raft api test to 60s #1738

merged 3 commits into from
Feb 21, 2022

Conversation

javeme
Copy link
Contributor

@javeme javeme commented Jan 21, 2022

Change-Id: Ifa93e46992e79cc9b0adc93ad529b72169ec7a7f

@javeme
set timeout of raft api test to 60s
736ccb5 
Change-Id: Ifa93e46992e79cc9b0adc93ad529b72169ec7a7f
@codecov
Copy link

codecov bot commented Jan 21, 2022 •
edited
Loading

Codecov Report

Merging #1738 (8c8cab4) into master (e9cef74) will increase coverage by 4.32%.
The diff coverage is n/a.

Impacted file tree graph

@@             Coverage Diff              @@
##             master    #1738      +/-   ##
============================================
+ Coverage     66.46%   70.78%   +4.32%     
- Complexity      684      970     +286     
============================================
  Files           443      443              
  Lines         37678    37704      +26     
  Branches       5361     5370       +9     
============================================
+ Hits          25042    26690    +1648     
+ Misses        10035     8317    -1718     
- Partials       2601     2697      +96
Impacted Files Coverage Δ
.../baidu/hugegraph/backend/query/ConditionQuery.java 85.14% <0.00%> (-0.84%) ⬇️
...va/com/baidu/hugegraph/util/collection/IntMap.java 72.40% <0.00%> (-0.40%) ⬇️
...java/com/baidu/hugegraph/structure/HugeVertex.java 79.15% <0.00%> (+0.35%) ⬆️
...aidu/hugegraph/backend/serializer/BytesBuffer.java 89.34% <0.00%> (+0.45%) ⬆️
...gegraph/backend/cache/CachedSchemaTransaction.java 91.30% <0.00%> (+0.48%) ⬆️
...aidu/hugegraph/backend/store/mysql/MysqlTable.java 81.59% <0.00%> (+0.54%) ⬆️
.../main/java/com/baidu/hugegraph/util/Consumers.java 57.14% <0.00%> (+0.68%) ⬆️
...in/java/com/baidu/hugegraph/StandardHugeGraph.java 67.13% <0.00%> (+0.70%) ⬆️
...om/baidu/hugegraph/task/StandardTaskScheduler.java 76.34% <0.00%> (+0.73%) ⬆️
...va/com/baidu/hugegraph/backend/id/IdGenerator.java 77.20% <0.00%> (+0.73%) ⬆️
... and 55 more

Continue to review full report at Codecov.

Legend - Click here to learn more
Δ = absolute <relative> (impact), ø = not affected, ? = missing data
Powered by Codecov. Last update e9cef74...8c8cab4. Read the comment docs.

@javeme
Copy link
Contributor Author

javeme commented Jan 21, 2022 •
edited
Loading

raft ci error:

[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
Error:  Tests run: 53, Failures: 4, Errors: 33, Skipped: 0, Time elapsed: 74.035 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite
Error:  testEliminate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.114 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testEliminate(IndexLabelApiTest.java:94)

Error:  testEliminate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.115 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  testAppend(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.038 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testAppend(IndexLabelApiTest.java:66)


[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
Error:  Tests run: 50, Failures: 1, Errors: 30, Skipped: 0, Time elapsed: 103.208 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite
Error:  testDelete(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.093 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testDelete(IndexLabelApiTest.java:150)

Error:  testDelete(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.093 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels


[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
Error:  Tests run: 52, Failures: 3, Errors: 32, Skipped: 0, Time elapsed: 85.072 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite
Error:  testAppend(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.111 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testAppend(IndexLabelApiTest.java:66)

Error:  testAppend(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.112 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  testCreate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.03 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testCreate(IndexLabelApiTest.java:52)

Error:  testCreate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.036 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  testDelete(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.034 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testDelete(IndexLabelApiTest.java:150)

Error:  testDelete(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.035 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  com.baidu.hugegraph.api.SchemaApiTest  Time elapsed: 0.122 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  com.baidu.hugegraph.api.VertexApiTest  Time elapsed: 0.16 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels
[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
Error:  Tests run: 72, Failures: 7, Errors: 35, Skipped: 0, Time elapsed: 667.2 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite
Error:  testGet(com.baidu.hugegraph.api.EdgeApiTest)  Time elapsed: 21.125 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to get vertex id: {"vertices":[]}
	at com.baidu.hugegraph.api.EdgeApiTest.testGet(EdgeApiTest.java:145)

Error:  testList(com.baidu.hugegraph.api.EdgeApiTest)  Time elapsed: 21.019 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to get vertex id: {"vertices":[]}
	at com.baidu.hugegraph.api.EdgeApiTest.testList(EdgeApiTest.java:168)

Error:  testCreate(com.baidu.hugegraph.api.EdgeApiTest)  Time elapsed: 20.253 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to get vertex id: {"vertices":[]}
	at com.baidu.hugegraph.api.EdgeApiTest.testCreate(EdgeApiTest.java:47)

Error:  testDelete(com.baidu.hugegraph.api.EdgeApiTest)  Time elapsed: 18.034 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to get vertex id: {"vertices":[]}
	at com.baidu.hugegraph.api.EdgeApiTest.testDelete(EdgeApiTest.java:190)

Error:  testTruncate(com.baidu.hugegraph.api.GremlinApiTest)  Time elapsed: 61.088 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class java.lang.IllegalArgumentException","message":"Undefined vertex label: '~user'","cause":""} expected:<200> but was:<400>
	at com.baidu.hugegraph.api.GremlinApiTest.testTruncate(GremlinApiTest.java:135)

Error:  testTruncate(com.baidu.hugegraph.api.GremlinApiTest)  Time elapsed: 61.088 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list edges

Error:  testGet(com.baidu.hugegraph.api.GremlinApiTest)  Time elapsed: 2.003 s  <<< FAILURE!
java.lang.AssertionError: {"exception":"class java.lang.IllegalArgumentException","message":"Undefined vertex label: '~user'","cause":""} expected:<200> but was:<400>
	at com.baidu.hugegraph.api.GremlinApiTest.testGet(GremlinApiTest.java:52)

Error:  testGet(com.baidu.hugegraph.api.GremlinApiTest)  Time elapsed: 2.003 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list edges

Error:  testPost(com.baidu.hugegraph.api.GremlinApiTest)  Time elapsed: 0.018 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class java.lang.IllegalArgumentException","message":"Undefined vertex label: '~user'","cause":""} expected:<200> but was:<400>
	at com.baidu.hugegraph.api.GremlinApiTest.testPost(GremlinApiTest.java:44)
[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
Error:  Tests run: 84, Failures: 1, Errors: 0, Skipped: 1, Time elapsed: 202.13 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite
Error:  testList(com.baidu.hugegraph.api.TaskApiTest)  Time elapsed: 8.97 s  <<< FAILURE!
java.lang.AssertionError: [{task_name=INDEX_LABEL:8:personByCity, task_progress=0, task_create=1644382982551, task_status=running, task_update=1644382984353, task_retries=0, id=90, task_type=rebuild_index, task_server=server3}]
	at com.baidu.hugegraph.api.TaskApiTest.testList(TaskApiTest.java:65)
[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
[ERROR] Tests run: 84, Failures: 2, Errors: 0, Skipped: 1, Time elapsed: 2,114.362 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite

[ERROR] testTruncate(com.baidu.hugegraph.api.GremlinApiTest)  Time elapsed: 65.256 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"java.lang.IllegalArgumentException","message":"Undefined vertex label: '~user'","cause":"[java.lang.IllegalArgumentException]"} expected:<200> but was:<400>
	at com.baidu.hugegraph.api.GremlinApiTest.testTruncate(GremlinApiTest.java:135)

Log:
2022-02-21 18:00:32 [gremlin-server-exec-3] [WARN] o.a.t.g.s.h.HttpGremlinEndpointHandler - Invalid request - responding with 500 Internal Server Error and Undefined vertex label: '~user'
java.lang.IllegalArgumentException: Undefined vertex label: '~user'
        at com.google.common.base.Preconditions.checkArgument(Preconditions.java:163) ~[guava-25.1-jre.jar:?]
        at com.baidu.hugegraph.util.E.checkArgument(E.java:56) ~[hugegraph-common-2.0.1.jar:2.0.1.0]
        at com.baidu.hugegraph.StandardHugeGraph.vertexLabel(StandardHugeGraph.java:774) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.lambda$vertexLabel$2(HugeGraphAuthProxy.java:253) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.lambda$verifySchemaPermission$24(HugeGraphAuthProxy.java:907) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.verifyResPermission(HugeGraphAuthProxy.java:932) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.verifyResPermission(HugeGraphAuthProxy.java:918) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.verifySchemaPermission(HugeGraphAuthProxy.java:905) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.verifySchemaPermission(HugeGraphAuthProxy.java:898) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.vertexLabel(HugeGraphAuthProxy.java:252) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.EntityManager.queryEntity(EntityManager.java:156) ~[hugegraph-core-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.EntityManager.query(EntityManager.java:138) ~[hugegraph-core-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.StandardAuthManager.findUser(StandardAuthManager.java:204) ~[hugegraph-core-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.truncateBackend(HugeGraphAuthProxy.java:719) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.HugeGraph$truncateBackend.call(Unknown Source) ~[?:?]
        at Script3.run(Script3.groovy:1) ~[?:?]
        at org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:674) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:376) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at javax.script.AbstractScriptEngine.eval(AbstractScriptEngine.java:233) ~[?:1.8.0_111]
        at org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor.lambda$eval$0(GremlinExecutor.java:266) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_111]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_111]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_111]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy$ContextTask.run(HugeGraphAuthProxy.java:1748) [hugegraph-api-0.12.0.jar:0.67.0.0]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [?:1.8.0_111]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [?:1.8.0_111]
        at java.lang.Thread.run(Thread.java:745) [?:1.8.0_111]
2022-02-21 18:00:32 [gremlin-server-worker-1] [WARN] o.a.t.g.s.h.HttpGremlinEndpointHandler - Invalid request - responding with 500 Internal Server Error and Script evaluation exceeded the configured 'scriptEvaluationTimeout' threshold of 60000 ms or evaluation was otherwise cancelled directly for request [try {hugegraph.truncateBackend()} catch (UnsupportedOperationException e) {}]
java.util.concurrent.TimeoutException: Script evaluation exceeded the configured 'scriptEvaluationTimeout' threshold of 60000 ms or evaluation was otherwise cancelled directly for request [try {hugegraph.truncateBackend()} catch (UnsupportedOperationException e) {}]
        at org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor.lambda$eval$1(GremlinExecutor.java:315) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at io.netty.util.concurrent.PromiseTask$RunnableAdapter.call(PromiseTask.java:38) [netty-all-4.1.42.Final.jar:4.1.42.Final]
        at io.netty.util.concurrent.ScheduledFutureTask.run(ScheduledFutureTask.java:139) [netty-all-4.1.42.Final.jar:4.1.42.Final]
        at io.netty.util.concurrent.AbstractEventExecutor.safeExecute(AbstractEventExecutor.java:163) [netty-all-4.1.42.Final.jar:4.1.42.Final]
        at io.netty.util.concurrent.SingleThreadEventExecutor.runAllTasks(SingleThreadEventExecutor.java:510) [netty-all-4.1.42.Final.jar:4.1.42.Final]
        at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:518) [netty-all-4.1.42.Final.jar:4.1.42.Final]
        at io.netty.util.concurrent.SingleThreadEventExecutor$6.run(SingleThreadEventExecutor.java:1044) [netty-all-4.1.42.Final.jar:4.1.42.Final]
        at io.netty.util.internal.ThreadExecutorMap$2.run(ThreadExecutorMap.java:74) [netty-all-4.1.42.Final.jar:4.1.42.Final]
        at java.lang.Thread.run(Thread.java:745) [?:1.8.0_111]
2022-02-21 18:00:32 [gremlin-server-exec-2] [WARN] c.b.h.b.s.r.RaftBackendStoreProvider - start=Error when waiting for event execution: store.inited
java.lang.InterruptedException: null
        at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:404) ~[?:1.8.0_111]
        at java.util.concurrent.FutureTask.get(FutureTask.java:191) ~[?:1.8.0_111]
        at com.baidu.hugegraph.backend.store.raft.RaftBackendStoreProvider.notifyAndWaitEvent(RaftBackendStoreProvider.java:259) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at com.baidu.hugegraph.backend.store.raft.RaftBackendStoreProvider.initSystemInfo(RaftBackendStoreProvider.java:199) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at com.baidu.hugegraph.StandardHugeGraph.truncateBackend(StandardHugeGraph.java:367) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.truncateBackend(HugeGraphAuthProxy.java:721) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.HugeGraph$truncateBackend.call(Unknown Source) ~[?:?]
        at org.codehaus.groovy.runtime.callsite.CallSiteArray.defaultCall(CallSiteArray.java:47) ~[groovy-2.5.7-indy.jar:2.5.7]
        at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:115) ~[groovy-2.5.7-indy.jar:2.5.7]
        at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:119) ~[groovy-2.5.7-indy.jar:2.5.7]
        at Script3.run(Script3.groovy:1) ~[?:?]
        at org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:674) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:376) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at javax.script.AbstractScriptEngine.eval(AbstractScriptEngine.java:233) ~[?:1.8.0_111]
        at org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor.lambda$eval$0(GremlinExecutor.java:266) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_111]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) ~[?:1.8.0_111]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_111]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy$ContextTask.run(HugeGraphAuthProxy.java:1748) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) ~[?:1.8.0_111]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) ~[?:1.8.0_111]
        at java.lang.Thread.run(Thread.java:745) [?:1.8.0_111]
2022-02-21 18:00:52 [gremlin-server-exec-3] [WARN] o.a.t.g.s.h.HttpGremlinEndpointHandler - Invalid request - responding with 500 Internal Server Error and Invalid cardinality 'list' for property key 'foo', expect 'single'
java.lang.IllegalArgumentException: Invalid cardinality 'list' for property key 'foo', expect 'single'
        at com.google.common.base.Preconditions.checkArgument(Preconditions.java:163) ~[guava-25.1-jre.jar:?]
        at com.baidu.hugegraph.util.E.checkArgument(E.java:56) ~[hugegraph-common-2.0.1.jar:2.0.1.0]
        at com.baidu.hugegraph.structure.HugeVertex.property(HugeVertex.java:452) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at org.apache.tinkerpop.gremlin.process.traversal.step.sideEffect.AddPropertyStep.sideEffect(AddPropertyStep.java:120) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.process.traversal.step.sideEffect.SideEffectStep.processNextStart(SideEffectStep.java:39) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.process.traversal.step.util.AbstractStep.hasNext(AbstractStep.java:143) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.process.traversal.step.util.ExpandableStepIterator.next(ExpandableStepIterator.java:50) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.process.traversal.step.sideEffect.SideEffectStep.processNextStart(SideEffectStep.java:38) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.process.traversal.step.util.AbstractStep.hasNext(AbstractStep.java:143) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.process.traversal.util.DefaultTraversal.hasNext(DefaultTraversal.java:197) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.util.iterator.IteratorUtils.fill(IteratorUtils.java:62) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.util.iterator.IteratorUtils.list(IteratorUtils.java:85) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.util.iterator.IteratorUtils.asList(IteratorUtils.java:382) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.server.handler.HttpGremlinEndpointHandler.lambda$channelRead$1(HttpGremlinEndpointHandler.java:245) ~[gremlin-server-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.util.function.FunctionUtils.lambda$wrapFunction$0(FunctionUtils.java:36) ~[gremlin-core-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor.lambda$eval$0(GremlinExecutor.java:272) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_111]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_111]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_111]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy$ContextTask.run(HugeGraphAuthProxy.java:1748) [hugegraph-api-0.12.0.jar:0.67.0.0]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [?:1.8.0_111]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [?:1.8.0_111]
        at java.lang.Thread.run(Thread.java:745) [?:1.8.0_111]
2022-02-21 18:01:42 [gremlin-server-exec-2] [WARN] c.b.h.b.s.r.RaftBackendStoreProvider - end=Error when waiting for event execution: store.inited
java.lang.InterruptedException: null
        at java.util.concurrent.FutureTask.awaitDone(FutureTask.java:404) ~[?:1.8.0_111]
        at java.util.concurrent.FutureTask.get(FutureTask.java:191) ~[?:1.8.0_111]
        at com.baidu.hugegraph.backend.store.raft.RaftBackendStoreProvider.notifyAndWaitEvent(RaftBackendStoreProvider.java:259) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at com.baidu.hugegraph.backend.store.raft.RaftBackendStoreProvider.initSystemInfo(RaftBackendStoreProvider.java:199) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at com.baidu.hugegraph.StandardHugeGraph.truncateBackend(StandardHugeGraph.java:367) ~[hugegraph-core-0.12.0.jar:0.12.0.0]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy.truncateBackend(HugeGraphAuthProxy.java:721) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at com.baidu.hugegraph.HugeGraph$truncateBackend.call(Unknown Source) ~[?:?]
        at org.codehaus.groovy.runtime.callsite.CallSiteArray.defaultCall(CallSiteArray.java:47) ~[groovy-2.5.7-indy.jar:2.5.7]
        at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:115) ~[groovy-2.5.7-indy.jar:2.5.7]
        at org.codehaus.groovy.runtime.callsite.AbstractCallSite.call(AbstractCallSite.java:119) ~[groovy-2.5.7-indy.jar:2.5.7]
        at Script3.run(Script3.groovy:1) ~[?:?]
        at org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:674) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at org.apache.tinkerpop.gremlin.groovy.jsr223.GremlinGroovyScriptEngine.eval(GremlinGroovyScriptEngine.java:376) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at javax.script.AbstractScriptEngine.eval(AbstractScriptEngine.java:233) ~[?:1.8.0_111]
        at org.apache.tinkerpop.gremlin.groovy.engine.GremlinExecutor.lambda$eval$0(GremlinExecutor.java:266) ~[gremlin-groovy-3.4.3.jar:3.4.3]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_111]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) ~[?:1.8.0_111]
        at java.util.concurrent.FutureTask.run(FutureTask.java:266) ~[?:1.8.0_111]
        at com.baidu.hugegraph.auth.HugeGraphAuthProxy$ContextTask.run(HugeGraphAuthProxy.java:1748) ~[hugegraph-api-0.12.0.jar:0.67.0.0]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) ~[?:1.8.0_111]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) ~[?:1.8.0_111]
        at java.lang.Thread.run(Thread.java:745) [?:1.8.0_111]
2022-02-21 18:01:42 [gremlin-server-exec-2] [INFO] c.b.h.HugeGraph - Init server info [server1-MASTER] for graph 'hugegraph'...
2022-02-21 18:01:43 [gremlin-server-exec-2] [INFO] c.b.h.t.ServerInfoManager - Init server info: HugeServerInfo(server1){server_load=0, server_role=MASTER, id=server1, label=~server, server_update_time=Mon Feb 21 18:01:43 CST 2022, server_max_load=10000}
2022-02-21 18:01:43 [gremlin-server-exec-2] [INFO] c.b.h.HugeGraph - Check olap property-key tables for graph 'hugegraph'
2022-02-21 18:01:44 [gremlin-server-exec-2] [INFO] c.b.h.HugeGraph - Restoring incomplete tasks for graph 'hugegraph'...
2022-02-21 18:01:44 [gremlin-server-exec-2] [INFO] c.b.h.HugeGraph - Graph 'hugegraph' has been truncated
2022-02-21 18:01:45 [task-scheduler-1] [INFO] c.b.h.t.TaskScheduler - Scheduled task '1' to server 'server1'

@javeme
Copy link
Contributor Author

javeme commented Feb 8, 2022 •
edited
Loading

unit test error:

Error:  Tests run: 391, Failures: 0, Errors: 1, Skipped: 1, Time elapsed: 628.336 s <<< FAILURE! - in com.baidu.hugegraph.unit.UnitTestSuite
Error:  testMultiThreadsGetAndUpdateWithGtCapacity(com.baidu.hugegraph.unit.cache.CacheTest$RamCacheTest)  Time elapsed: 27.98 s  <<< ERROR!
java.lang.RuntimeException: java.util.concurrent.ExecutionException: java.lang.AssertionError
Caused by: java.util.concurrent.ExecutionException: java.lang.AssertionError
Caused by: java.lang.AssertionError

log:

Error: -28 04:08:55 [main] [ERROR] c.b.h.u.BaseUnitTest - null
java.lang.AssertionError: null
	at com.baidu.hugegraph.backend.cache.RamCache$LinkedQueueNonBigLock.remove(RamCache.java:474) ~[classes/:?]
	at com.baidu.hugegraph.backend.cache.RamCache.write(RamCache.java:156) ~[classes/:?]
	at com.baidu.hugegraph.backend.cache.RamCache.write(RamCache.java:35) ~[classes/:?]
	at com.baidu.hugegraph.backend.cache.AbstractCache.update(AbstractCache.java:137) ~[classes/:?]
	at com.baidu.hugegraph.backend.cache.AbstractCache.update(AbstractCache.java:128) ~[classes/:?]
	at com.baidu.hugegraph.unit.cache.CacheTest.lambda$testMultiThreadsGetAndUpdateWithGtCapacity$8(CacheTest.java:746) ~[classes/:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:515) ~[?:?]
	at java.util.concurrent.FutureTask.run(FutureTask.java:264) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128) ~[?:?]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628) ~[?:?]
	at java.lang.Thread.run(Thread.java:829) [?:?]

@javeme
improve test error log
b276398 
Change-Id: I0f3a00558ed9ccb4abb92465e13fae8fbcfd7338
@javeme
Copy link
Contributor Author

javeme commented Feb 9, 2022 •
edited
Loading

hbase test error:

[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
Error:  Tests run: 62, Failures: 3, Errors: 28, Skipped: 0, Time elapsed: 14.642 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite
Error:  testList(com.baidu.hugegraph.api.TaskApiTest)  Time elapsed: 0.111 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByCity' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.TaskApiTest.prepareSchema(TaskApiTest.java:42)

Error:  testList(com.baidu.hugegraph.api.TaskApiTest)  Time elapsed: 0.111 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  testCancel(com.baidu.hugegraph.api.TaskApiTest)  Time elapsed: 0.03 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByCity' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.TaskApiTest.prepareSchema(TaskApiTest.java:42)

Error:  testCancel(com.baidu.hugegraph.api.TaskApiTest)  Time elapsed: 0.033 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  testDelete(com.baidu.hugegraph.api.TaskApiTest)  Time elapsed: 0.029 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByCity' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.TaskApiTest.prepareSchema(TaskApiTest.java:42)

Error:  testDelete(com.baidu.hugegraph.api.TaskApiTest)  Time elapsed: 0.029 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

Error:  com.baidu.hugegraph.api.GremlinApiTest  Time elapsed: 0.082 s  <<< ERROR!
com.baidu.hugegraph.HugeException: Failed to list indexlabels

rocksdb (without raft) test error:

[INFO]  T E S T S
[INFO] -------------------------------------------------------
[INFO] Running com.baidu.hugegraph.api.ApiTestSuite
Error:  Tests run: 54, Failures: 39, Errors: 0, Skipped: 0, Time elapsed: 9.504 s <<< FAILURE! - in com.baidu.hugegraph.api.ApiTestSuite
Error:  testList(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.07 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testList(IndexLabelApiTest.java:134)

Error:  testList(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.075 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.HugeException","message":"Failed to serialize indexlabels","cause":"com.baidu.hugegraph.HugeException: Can't write json: Undefined vertex label with id: '16' (through reference chain: java.util.ArrayList[0])"} expected:<200> but was:<400>

Error:  testEliminate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.066 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testEliminate(IndexLabelApiTest.java:94)

Error:  testEliminate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.067 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.HugeException","message":"Failed to serialize indexlabels","cause":"com.baidu.hugegraph.HugeException: Can't write json: Undefined vertex label with id: '16' (through reference chain: java.util.ArrayList[0])"} expected:<200> but was:<400>

Error:  testAppend(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.055 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testAppend(IndexLabelApiTest.java:66)

Error:  testAppend(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.055 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.HugeException","message":"Failed to serialize indexlabels","cause":"com.baidu.hugegraph.HugeException: Can't write json: Undefined vertex label with id: '16' (through reference chain: java.util.ArrayList[0])"} expected:<200> but was:<400>

Error:  testCreate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.054 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testCreate(IndexLabelApiTest.java:52)

Error:  testCreate(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.054 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.HugeException","message":"Failed to serialize indexlabels","cause":"com.baidu.hugegraph.HugeException: Can't write json: Undefined vertex label with id: '16' (through reference chain: java.util.ArrayList[0])"} expected:<200> but was:<400>

Error:  testDelete(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.051 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.exception.ExistedException","message":"The index label 'personByAge' has existed","cause":""} expected:<202> but was:<400>
	at com.baidu.hugegraph.api.IndexLabelApiTest.testDelete(IndexLabelApiTest.java:150)

Error:  testDelete(com.baidu.hugegraph.api.IndexLabelApiTest)  Time elapsed: 0.051 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.HugeException","message":"Failed to serialize indexlabels","cause":"com.baidu.hugegraph.HugeException: Can't write json: Undefined vertex label with id: '16' (through reference chain: java.util.ArrayList[0])"} expected:<200> but was:<400>

Error:  com.baidu.hugegraph.api.SchemaApiTest  Time elapsed: 0.139 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.HugeException","message":"Failed to serialize indexlabels","cause":"com.baidu.hugegraph.HugeException: Can't write json: Undefined vertex label with id: '16' (through reference chain: java.util.ArrayList[0])"} expected:<200> but was:<400>

Error:  com.baidu.hugegraph.api.VertexApiTest  Time elapsed: 0.215 s  <<< FAILURE!
java.lang.AssertionError: Response with status 400 and content {"exception":"class com.baidu.hugegraph.HugeException","message":"Failed to serialize indexlabels","cause":"com.baidu.hugegraph.HugeException: Can't write json: Undefined vertex label with id: '16' (through reference chain: java.util.ArrayList[0])"} expected:<200> but was:<400>

@javeme
improve error message "Failed to list indexlabels"
8c8cab4 
Change-Id: I4de923541ba6291f07779a4dedcafad887ac3037
javeme
javeme commented Feb 9, 2022
View reviewed changes
hugegraph-test/src/main/java/com/baidu/hugegraph/api/TaskApiTest.java
r = client().get(path, ImmutableMap.of("status", "RUNNING"));
content = assertResponseStatus(200, r);
tasks = assertJsonContains(content, "tasks");
Assert.assertTrue(tasks.isEmpty());
Assert.assertTrue(tasks.toString(), tasks.isEmpty());
Copy link
Contributor Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

may be caused by:

  • raft async apply?
  • update status after task.done()?

@javeme javeme merged commit 5cdf770 into master Feb 21, 2022
@javeme javeme deleted the test-timout branch February 21, 2022 07:58
@javeme javeme mentioned this pull request Feb 28, 2022
Merged
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Reviewers

@coderzc coderzc coderzc approved these changes

@imbajin imbajin imbajin approved these changes

Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

Successfully merging this pull request may close these issues.
3 participants
@javeme @imbajin @coderzc