Details
-
Bug
-
Status: Resolved
-
Major
-
Resolution: Fixed
-
0.9.9
-
None
Description
This seems to happen about 50% of the time in the set of jenkins jobs that run ExecutionTest suites. It doesn't always happen in the same place. The suite will hang due to the query failing to return, and the job is then aborted.
03:26:00.310 [HttpExecutor(port:19002)-6] INFO org.apache.asterix.api.http.server.QueryServiceServlet - handleRequest: uuid=ae57875a-fb85-4a73-8777-4245de050238, clientContextID=null, {"host":"127.0.0.1:19002","path":"/query/service","statement":"\\/*\\n * Licensed to the Apache Software Foundation (ASF) under one\\n * or more contributor license agreements. See the NOTICE file\\n * distributed with this work for additional information\\n * regarding copyright ownership. The ASF licenses this file\\n * to you under the Apache License, Version 2.0 (the\\n * \\\"License\\\"); you may not use this file except in compliance\\n * with the License. You may obtain a copy of the License at\\n *\\n * http:\\/\\/www.apache.org\\/licenses\\/LICENSE-2.0\\n *\\n * Unless required by applicable law or agreed to in writing,\\n * software distributed under the License is distributed on an\\n * \\\"AS IS\\\" BASIS, WITHOUT WARRANTIES OR CONDITIONS OF ANY\\n * KIND, either express or implied. See the License for the\\n * specific language governing permissions and limitations\\n * under the License.\\n *\\/\\n\\nUSE test;\\n\\nINSERT INTO DBLP {\\\"id\\\":6, \\\"authors\\\":\\\"asdaskhdaskj dhas dhkasj dsakjdh\\\"};\\nINSERT INTO CSX {\\\"id\\\":7, \\\"authors\\\":\\\"asdaskhdaskj dhas dhkasj dsakjdh\\\"};\\n","pretty":false,"mode":"immediate","clientContextID":null,"clientType":"ASTERIX","dataverse":null,"format":"ADM","timeout":9223372036854775807,"maxResultReads":1,"planFormat":"STRING","expressionTree":false,"rewrittenExpressionTree":false,"logicalPlan":false,"optimizedLogicalPlan":false,"job":false,"profile":"counts","signature":true,"multiStatement":true,"parseOnly":false,"readOnly":false,"maxWarnings":0,"sqlCompat":false,"source":null} 03:26:00.314 [SA:JID:0.29636:TAID:TID:ANID:ODID:0:0:0:0:0] INFO org.apache.asterix.common.context.GlobalVirtualBufferCache - Registered primary index {"class" : "LSMColumnBTree", "dir" : "/home/jenkins/workspace/asterix-gerrit-ssl-compression/asterixdb/asterix-app/target/io/dir/asterix_nc1/target/tmp/asterix_nc1/iodevice1/storage/partition_0/test/DBLP/0/DBLP", "memory" : [{"class":"LSMBTreeMemoryComponent", "state":"INACTIVE", "writers":0, "readers":0, "pendingFlushes":0, "id":"null", "index":{"class":"BTree","file":"storage/partition_0/test/DBLP/0/DBLP_virtual_0"}}, {"class":"LSMBTreeMemoryComponent", "state":"INACTIVE", "writers":0, "readers":0, "pendingFlushes":0, "id":"null", "index":{"class":"BTree","file":"storage/partition_0/test/DBLP/0/DBLP_virtual_1"}}], "disk" : 0, "num-scheduled-flushes":0, "current-memory-component":0} to the global VBC 03:26:00.314 [Executor-16:ClusterController] INFO org.apache.asterix.messaging.CCMessageBroker - Received message: AtomicJobPreparedMessage{jobId=JID:0.29636, nodeId='asterix_nc2'} 03:26:00.314 [Executor-16:ClusterController] WARN org.apache.asterix.app.cc.GlobalTxManager - JobPreparedMessage received for jobId JID:0.29636, which does not exist. The transaction for the job is already aborted 03:26:00.314 [Executor-8:ClusterController] INFO org.apache.asterix.messaging.CCMessageBroker - Received message: AtomicJobPreparedMessage{jobId=JID:0.29636, nodeId='asterix_nc2'} 03:26:00.314 [Executor-8:ClusterController] WARN org.apache.asterix.app.cc.GlobalTxManager - JobPreparedMessage received for jobId JID:0.29636, which does not exist. The transaction for the job is already aborted 03:26:00.314 [Executor-16:ClusterController] INFO org.apache.asterix.messaging.CCMessageBroker - Received message: AtomicJobPreparedMessage{jobId=JID:0.29636, nodeId='asterix_nc1'} 03:26:00.314 [Executor-16:ClusterController] WARN org.apache.asterix.app.cc.GlobalTxManager - JobPreparedMessage received for jobId JID:0.29636, which does not exist. The transaction for the job is already aborted 03:26:00.315 [QueryTranslator:ae57875a-fb85-4a73-8777-4245de050238] INFO org.apache.asterix.app.translator.QueryTranslator - Created job JID:0.29636 for uuid:ae57875a-fb85-4a73-8777-4245de050238, clientContextID:null 03:26:00.316 [Executor-14:ClusterController] INFO org.apache.asterix.messaging.CCMessageBroker - Received message: AtomicJobPreparedMessage{jobId=JID:0.29636, nodeId='asterix_nc1'}