File download failure

0
Hello, We have a microflow that export data into excel in batches of size 4000 rows. If there 6000 rows, 2 excel files(one includes 4000 rows + second includes 2000 rows) are created and zipped. Lately we experienced failure in the download of the zip file with long waiting time. We see that file is generated but it is not being downloaded with generic error in UI: An error occurred. Contact to your Administrator. Initially we were not seeing any error in the console but just a warning:   7/6/2023, 7:23:41.000 AM,"java.lang.NullPointerException: null"7/6/2023, 7:23:41.000 AM,"WARNING - Core: Failed cluster management action: cleanup orphaned files."7/6/2023, 7:23:41.000 AM," at scala.collection.StringOps$.forall$extension(StringOps.scala:1050)"7/6/2023, 7:23:41.000 AM," at com.mendix.filedocumentprocessor.UnreferencedFileCleanup.$anonfun$retrieveReferencedFiles$1(UnreferencedFileCleanup.scala:180)"7/6/2023, 7:23:41.000 AM," at com.mendix.filedocumentprocessor.UnreferencedFileCleanup.$anonfun$retrieveReferencedFiles$1$adapted(UnreferencedFileCleanup.scala:180)"7/6/2023, 7:23:41.000 AM," at scala.collection.immutable.List.filter(List.scala:515)"7/6/2023, 7:23:41.000 AM," at scala.collection.immutable.List.filter(List.scala:79)"7/6/2023, 7:23:41.000 AM," at com.mendix.filedocumentprocessor.UnreferencedFileCleanup.retrieveReferencedFiles(UnreferencedFileCleanup.scala:180)"7/6/2023, 7:23:41.000 AM," at com.mendix.filedocumentprocessor.UnreferencedFileCleanup.deleteUnreferencedFiles(UnreferencedFileCleanup.scala:144)"7/6/2023, 7:23:41.000 AM," at com.mendix.filedocumentprocessor.UnreferencedFileCleanup.cleanup$1(UnreferencedFileCleanup.scala:100)"7/6/2023, 7:23:41.000 AM," at com.mendix.filedocumentprocessor.UnreferencedFileCleanup.cleanUpOrphans(UnreferencedFileCleanup.scala:104)"7/6/2023, 7:23:41.000 AM," at com.mendix.basis.action.system.ClusterManagementAction$.$anonfun$cleanupOrphanFiles$2(ClusterManagementAction.scala:76)"7/6/2023, 7:23:41.000 AM," at com.mendix.basis.action.system.ClusterManagementAction$.$anonfun$cleanupOrphanFiles$2$adapted(ClusterManagementAction.scala:75)"7/6/2023, 7:23:41.000 AM," at com.mendix.basis.action.system.ClusterManagementAction$$anon$1.execute(ClusterManagementAction.scala:24)"7/6/2023, 7:23:41.000 AM," at com.mendix.basis.action.system.ManagementAction.executeWithLogging(ManagementAction.scala:21)"     Now we are receiving this error:   7/6/2023, 11:10:41.000 AM,"ERROR - Connector: An error has occurred while handling the request. "7/6/2023, 11:10:41.000 AM,"org.eclipse.jetty.io.EofException: null"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.SocketChannelEndPoint.flush(SocketChannelEndPoint.java:116)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.WriteFlusher.flush(WriteFlusher.java:422)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:275)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.WriteFlusher.write(WriteFlusher.java:254)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.AbstractEndPoint.write(AbstractEndPoint.java:386)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpConnection$SendCallback.process(HttpConnection.java:827)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.IteratingCallback.processing(IteratingCallback.java:243)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.IteratingCallback.iterate(IteratingCallback.java:224)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpConnection.send(HttpConnection.java:584)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpChannel.sendResponse(HttpChannel.java:1060)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpChannel.write(HttpChannel.java:1132)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpOutput.channelWrite(HttpOutput.java:270)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpOutput.channelWrite(HttpOutput.java:254)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:858)"7/6/2023, 11:10:41.000 AM," at java.base/sun.nio.cs.StreamEncoder.writeBytes(Unknown Source)"7/6/2023, 11:10:41.000 AM," at java.base/sun.nio.cs.StreamEncoder.implWrite(Unknown Source)"7/6/2023, 11:10:41.000 AM," at java.base/sun.nio.cs.StreamEncoder.write(Unknown Source)"7/6/2023, 11:10:41.000 AM," at java.base/java.io.OutputStreamWriter.write(Unknown Source)"7/6/2023, 11:10:41.000 AM," at com.fasterxml.jackson.core.json.WriterBasedJsonGenerator._flushBuffer(WriterBasedJsonGenerator.java:2060)"7/6/2023, 11:10:41.000 AM," at com.fasterxml.jackson.core.json.WriterBasedJsonGenerator.writeString(WriterBasedJsonGenerator.java:427)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.JsonGeneratorWrapper.$anonfun$writeString$1(JsonGeneratorWrapper.scala:39)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.JsonGeneratorWrapper.$anonfun$writeString$1$adapted(JsonGeneratorWrapper.scala:39)"7/6/2023, 11:10:41.000 AM," at scala.collection.IterableOnceOps.foreach(IterableOnce.scala:575)"7/6/2023, 11:10:41.000 AM," at scala.collection.IterableOnceOps.foreach$(IterableOnce.scala:573)"7/6/2023, 11:10:41.000 AM," at scala.collection.AbstractIterable.foreach(Iterable.scala:933)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.JsonGeneratorWrapper.writeString(JsonGeneratorWrapper.scala:39)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.generateJsValue(ResultSerializer.scala:68)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.$anonfun$generateJsValue$2(ResultSerializer.scala:66)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.$anonfun$generateJsValue$2$adapted(ResultSerializer.scala:66)"7/6/2023, 11:10:41.000 AM," at scala.collection.immutable.VectorStatics$.foreachRec(Vector.scala:1895)"7/6/2023, 11:10:41.000 AM," at scala.collection.immutable.VectorStatics$.foreachRec(Vector.scala:1901)"7/6/2023, 11:10:41.000 AM," at scala.collection.immutable.Vector.foreach(Vector.scala:1901)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.generateJsValue(ResultSerializer.scala:66)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.$anonfun$generateJsResult$2(ResultSerializer.scala:31)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.$anonfun$generateJsResult$2$adapted(ResultSerializer.scala:29)"7/6/2023, 11:10:41.000 AM," at scala.collection.IterableOps$WithFilter.foreach(Iterable.scala:903)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.generateJsResult(ResultSerializer.scala:29)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.actions.client.RegularClientAction.$anonfun$execute$2(RegularClientAction.scala:130)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.actions.client.RegularClientAction.$anonfun$execute$2$adapted(RegularClientAction.scala:118)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.helpers.ContextHandling.$anonfun$inContext$7(ContextHandling.scala:58)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.helpers.ContextHandling.inContext(ContextHandling.scala:58)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.helpers.ContextHandling.inContext$(ContextHandling.scala:32)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.actions.client.RegularClientAction.inContext(RegularClientAction.scala:94)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.helpers.ContextHandling.inContext(ContextHandling.scala:29)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.helpers.ContextHandling.inContext$(ContextHandling.scala:21)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.actions.client.RegularClientAction.$anonfun$execute$1(RegularClientAction.scala:118)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.helpers.ProfileHandling.profileRequest(ProfileHandling.scala:14)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.helpers.ProfileHandling.profileRequest$(ProfileHandling.scala:10)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.actions.client.RegularClientAction.profileRequest(RegularClientAction.scala:94)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.actions.client.RegularClientAction.execute(RegularClientAction.scala:115)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.ClientRequestHandler.handleAction(ClientRequestHandler.scala:105)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.ClientRequestHandler.processRequest(ClientRequestHandler.scala:78)"7/6/2023, 11:10:41.000 AM," at com.mendix.externalinterface.connector.RequestHandler.doProcessRequest(RequestHandler.java:37)"7/6/2023, 11:10:41.000 AM," at com.mendix.external.connector.MxRuntimeConnector.$anonfun$processRequest$1(MxRuntimeConnector.scala:54)"7/6/2023, 11:10:41.000 AM," at com.mendix.external.connector.MxRuntimeConnector.$anonfun$processRequest$1$adapted(MxRuntimeConnector.scala:54)"7/6/2023, 11:10:41.000 AM," at com.mendix.external.connector.MxRuntimeConnector.processRequest(MxRuntimeConnector.scala:54)"7/6/2023, 11:10:41.000 AM," at com.mendix.basis.impl.MxRuntimeImpl.processRequest(MxRuntimeImpl.scala:221)"7/6/2023, 11:10:41.000 AM," at com.mendix.m2ee.appcontainer.server.handler.RuntimeServlet.service(RuntimeServlet.scala:40)"7/6/2023, 11:10:41.000 AM," at javax.servlet.http.HttpServlet.service(HttpServlet.java:750)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:764)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.websocket.servlet.WebSocketUpgradeFilter.doFilter(WebSocketUpgradeFilter.java:170)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.servlet.FilterHolder.doFilter(FilterHolder.java:202)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.servlet.ServletHandler$Chain.doFilter(ServletHandler.java:1635)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:527)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.handler.ScopedHandler.nextHandle(ScopedHandler.java:221)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:1570)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1385)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:176)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:484)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:1543)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.handler.ScopedHandler.nextScope(ScopedHandler.java:174)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1307)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:129)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:122)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.Server.handle(Server.java:563)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpChannel.lambda$handle$0(HttpChannel.java:505)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpChannel.dispatch(HttpChannel.java:762)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:497)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:282)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:314)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:100)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:416)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:385)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:272)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.lambda$new$0(AdaptiveExecutionStrategy.java:140)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:411)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:936)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1080)"7/6/2023, 11:10:41.000 AM,"Caused by: java.io.IOException: Broken pipe"7/6/2023, 11:10:41.000 AM," at java.base/sun.nio.ch.FileDispatcherImpl.writev0(Native Method)"7/6/2023, 11:10:41.000 AM," at java.base/sun.nio.ch.SocketDispatcher.writev(Unknown Source)"7/6/2023, 11:10:41.000 AM," at java.base/sun.nio.ch.IOUtil.write(Unknown Source)"7/6/2023, 11:10:41.000 AM," at java.base/sun.nio.ch.SocketChannelImpl.write(Unknown Source)"7/6/2023, 11:10:41.000 AM," at java.base/java.nio.channels.SocketChannel.write(Unknown Source)"7/6/2023, 11:10:41.000 AM," at org.eclipse.jetty.io.SocketChannelEndPoint.flush(SocketChannelEndPoint.java:110)"7/6/2023, 11:10:41.000 AM,"ERROR - Connector: null"7/6/2023, 11:10:41.000 AM,"com.mendix.systemwideinterfaces.MendixRuntimeException: com.fasterxml.jackson.core.JsonGenerationException: Can not write a field name, expecting a value"7/6/2023, 11:10:41.000 AM," at com.mendix.util.classloading.Runner$.withContextClassLoader(Runner.scala:23)"7/6/2023, 11:10:41.000 AM,"Caused by: com.fasterxml.jackson.core.JsonGenerationException: Can not write a field name, expecting a value"7/6/2023, 11:10:41.000 AM," at com.fasterxml.jackson.core.JsonGenerator._reportError(JsonGenerator.java:2733)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.JsonGeneratorWrapper.$anonfun$writeFieldName$1(JsonGeneratorWrapper.scala:38)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.JsonGeneratorWrapper.$anonfun$writeFieldName$1$adapted(JsonGeneratorWrapper.scala:38)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.JsonGeneratorWrapper.writeFieldName(JsonGeneratorWrapper.scala:38)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.jsonserialization.ResultSerializer.$anonfun$generateJsResult$2(ResultSerializer.scala:30)"7/6/2023, 11:10:41.000 AM," at com.mendix.webui.requesthandling.ClientRequestHandler.handleAction(ClientRequestHandler.scala:110)"
asked
2 answers
1

It looks like something might be wrong with one of the fields:

 

“Caused by: com.fasterxml.jackson.core.JsonGenerationException: Can not write a field name, expecting a value"7/6/2023, 11:10:41.000 AM," 

 

It's hard to tell exactly what's wrong as we don't know the data set, but that should give you a starting point. If you're using any calculated attributes on your entity, that would also be good to look at, I've heard of them causing this issue.

 

 

 

 

answered
0

To me this looks like your file is already garbage collected. Are the files committed to the database? Could you explain a bit how you create the files and put them in zip file?

Regards,

Ronald

 

answered