Date: prev next · Thread: first prev next last
2017 Archives by date, by thread · List index


Hello,

Our LibreOffice Online shutdown yesterday without error in logs.

Has anyone had a similary problem?

I join in this mail a few lines of the log

Thanks in advance.

RAMAMONJY Harifetra

wsd-08010-11026 11:01:10.531087 [ docbroker_1927 ] DBG  Removing tile: 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,30720.3840x3840.png|
 wsd/TileCache.cpp:334
wsd-08010-11026 11:01:10.531104 [ docbroker_1927 ] DBG  Removing tile: 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,11520.3840x3840.png|
 wsd/TileCache.cpp:334
wsd-08010-11026 11:01:10.531124 [ docbroker_1927 ] DBG  Removing tile: 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,26880.3840x3840.png|
 wsd/TileCache.cpp:334
wsd-08010-11026 11:01:10.531141 [ docbroker_1927 ] DBG  Removing tile: 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,11520.3840x3840.png|
 wsd/TileCache.cpp:334
wsd-08010-11026 11:01:10.531162 [ docbroker_1927 ] DBG  Removing tile: 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,7680.3840x3840.png|
 wsd/TileCache.cpp:334
wsd-08010-11026 11:01:10.531202 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.531228 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:10.531331 [ docbroker_1927 ] INF  ToClient-1f541: Command: unocommandresult: {
    "commandName": ".uno:Save",
    "success": "true",
    "result": {
        "type": "boolean"
    }
}
| wsd/ClientSession.cpp:539
wsd-08010-11026 11:01:10.531384 [ docbroker_1927 ] DBG  Persisting 
[193.168.56.101:443/c/common/wopi/files/104174473] after saving to URI 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit].|
 wsd/DocumentBroker.cpp:603
wsd-08010-11026 11:01:10.531417 [ docbroker_1927 ] INF  Uploading URI via WOPI 
[https://193.168.56.101:8888/c/common/wopi/files/104174473/contents?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit]
 from [/opt/online/jails/Afx2rmTrxJDMoZwI/user/docs/Afx2rmTrxJDMoZwI/TPE Y_T.odt].| 
wsd/Storage.cpp:636
wsd-08010-11026 11:01:10.547796 [ docbroker_1927 ] INF  WOPI::PutFile response: 
<html><head><title>Apache Tomcat/7.0.73 - Rapport d''erreur</title><style><!--H1 
{font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-size:22px;} H2 
{font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-size:16px;} H3 
{font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;font-size:14px;} BODY 
{font-family:Tahoma,Arial,sans-serif;color:black;background-color:white;} B 
{font-family:Tahoma,Arial,sans-serif;color:white;background-color:#525D76;} P 
{font-family:Tahoma,Arial,sans-serif;background:white;color:black;font-size:12px;}A {color : 
black;}A.name {color : black;}HR {color : #525D76;}--></style> </head><body><h1>Etat HTTP 500 - 
com.liferay.portlet.documentlibrary.NoSuchFileVersionException: No DLFileVersion exists with the 
primary key 104174473</h1><HR size="1" noshade="noshade"><p><b>type</b> Rapport 
d''exception</p><p><b>message</b> 
<u>com.liferay.portlet.documentlibrary.NoSuchFileVersionException: No DLFileVersion exists with the 
primary key 104174473</u></p><p><b>description</b> <u>Le serveur a rencontré une erreur interne 
qui l''a empêché de satisfaire la requête.</u></p><p><b>exception</b> 
<pre>javax.servlet.ServletException: 
com.liferay.portlet.documentlibrary.NoSuchFileVersionException: No DLFileVersion exists with the 
primary key 104174473
        org.apache.struts.action.RequestProcessor.processException(RequestProcessor.java:535)
        org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:433)
        org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:236)
        com.liferay.portal.struts.PortalRequestProcessor.process(PortalRequestProcessor.java:156)
        org.apache.struts.action.ActionServlet.process(ActionServlet.java:1196)
        org.apache.struts.action.ActionServlet.doPost(ActionServlet.java:432)
        javax.servlet.http.HttpServlet.service(HttpServlet.java:650)
        com.liferay.portal.servlet.MainServlet.callParentService(MainServlet.java:560)
        com.liferay.portal.servlet.MainServlet.service(MainServlet.java:537)
        javax.servlet.http.HttpServlet.service(HttpServlet.java:731)
        org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:72)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        com.liferay.portal.servlet.filters.strip.StripFilter.processFilter(StripFilter.java:335)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        com.liferay.portal.servlet.filters.secure.SecureFilter.processFilter(SecureFilter.java:297)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        
com.liferay.portal.servlet.filters.sso.ntlm.NtlmPostFilter.processFilter(NtlmPostFilter.java:83)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        com.liferay.portal.sharepoint.SharepointFilter.processFilter(SharepointFilter.java:80)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        
com.liferay.portal.servlet.filters.virtualhost.VirtualHostFilter.processFilter(VirtualHostFilter.java:216)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:187)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        org.tuckey.web.filters.urlrewrite.UrlRewriteFilter.doFilter(UrlRewriteFilter.java:738)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:167)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:167)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:187)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.doFilter(InvokerFilter.java:73)
</pre></p><p><b>cause mère</b> 
<pre>com.liferay.portlet.documentlibrary.NoSuchFileVersionException: No DLFileVersion exists with 
the primary key 104174473
        
com.liferay.portlet.documentlibrary.service.persistence.DLFileVersionPersistenceImpl.findByPrimaryKey(DLFileVersionPersistenceImpl.java:721)
        
com.liferay.portlet.documentlibrary.service.base.DLFileVersionLocalServiceBaseImpl.getDLFileVersion(DLFileVersionLocalServiceBaseImpl.java:243)
        sun.reflect.GeneratedMethodAccessor2656.invoke(Unknown Source)
        sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        java.lang.reflect.Method.invoke(Method.java:606)
        
com.liferay.portal.spring.aop.ServiceBeanMethodInvocation.proceed(ServiceBeanMethodInvocation.java:122)
        
com.liferay.portal.spring.transaction.TransactionInterceptor.invoke(TransactionInterceptor.java:71)
        
com.liferay.portal.spring.aop.ServiceBeanMethodInvocation.proceed(ServiceBeanMethodInvocation.java:118)
        com.liferay.portal.spring.aop.ChainableMethodAdvice.invoke(ChainableMethodAdvice.java:57)
        
com.liferay.portal.spring.aop.ServiceBeanMethodInvocation.proceed(ServiceBeanMethodInvocation.java:118)
        com.liferay.portal.spring.aop.ChainableMethodAdvice.invoke(ChainableMethodAdvice.java:57)
        
com.liferay.portal.spring.aop.ServiceBeanMethodInvocation.proceed(ServiceBeanMethodInvocation.java:118)
        com.liferay.portal.spring.aop.ChainableMethodAdvice.invoke(ChainableMethodAdvice.java:57)
        
com.liferay.portal.spring.aop.ServiceBeanMethodInvocation.proceed(ServiceBeanMethodInvocation.java:118)
        com.liferay.portal.spring.aop.ChainableMethodAdvice.invoke(ChainableMethodAdvice.java:57)
        
com.liferay.portal.spring.aop.ServiceBeanMethodInvocation.proceed(ServiceBeanMethodInvocation.java:118)
        com.liferay.portal.spring.aop.ServiceBeanAopProxy.invoke(ServiceBeanAopProxy.java:211)
        com.sun.proxy.$Proxy214.getDLFileVersion(Unknown Source)
        
com.liferay.portlet.documentlibrary.service.DLFileVersionLocalServiceUtil.getDLFileVersion(DLFileVersionLocalServiceUtil.java:185)
        com.pentila.entSavoie.wopiProtocole.GetWopiFileAction.saveFile(GetWopiFileAction.java:86)
        com.pentila.entSavoie.wopiProtocole.GetWopiFileAction.execute(GetWopiFileAction.java:57)
        org.apache.struts.action.RequestProcessor.processActionPerform(RequestProcessor.java:431)
        org.apache.struts.action.RequestProcessor.process(RequestProcessor.java:236)
        com.liferay.portal.struts.PortalRequestProcessor.process(PortalRequestProcessor.java:156)
        org.apache.struts.action.ActionServlet.process(ActionServlet.java:1196)
        org.apache.struts.action.ActionServlet.doPost(ActionServlet.java:432)
        javax.servlet.http.HttpServlet.service(HttpServlet.java:650)
        com.liferay.portal.servlet.MainServlet.callParentService(MainServlet.java:560)
        com.liferay.portal.servlet.MainServlet.service(MainServlet.java:537)
        javax.servlet.http.HttpServlet.service(HttpServlet.java:731)
        org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:72)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        com.liferay.portal.servlet.filters.strip.StripFilter.processFilter(StripFilter.java:335)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        com.liferay.portal.servlet.filters.secure.SecureFilter.processFilter(SecureFilter.java:297)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        
com.liferay.portal.servlet.filters.sso.ntlm.NtlmPostFilter.processFilter(NtlmPostFilter.java:83)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        com.liferay.portal.sharepoint.SharepointFilter.processFilter(SharepointFilter.java:80)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        com.liferay.portal.kernel.servlet.BaseFilter.processFilter(BaseFilter.java:163)
        
com.liferay.portal.servlet.filters.virtualhost.VirtualHostFilter.processFilter(VirtualHostFilter.java:216)
        com.liferay.portal.kernel.servlet.BaseFilter.doFilter(BaseFilter.java:57)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:187)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        org.tuckey.web.filters.urlrewrite.UrlRewriteFilter.doFilter(UrlRewriteFilter.java:738)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDoFilter(InvokerFilterChain.java:206)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:108)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:167)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:167)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:116)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.processDirectCallFilter(InvokerFilterChain.java:187)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilterChain.doFilter(InvokerFilterChain.java:95)
        
com.liferay.portal.kernel.servlet.filters.invoker.InvokerFilter.doFilter(InvokerFilter.java:73)
</pre></p><p><b>note</b> <u>La trace complète de la cause mère de cette erreur est disponible 
dans les fichiers journaux de Apache Tomcat/7.0.73.</u></p><HR size="1" 
noshade="noshade"><h3>Apache Tomcat/7.0.73</h3></body></html>| wsd/Storage.cpp:658
wsd-08010-11026 11:01:10.547882 [ docbroker_1927 ] INF  WOPI::PutFile uploaded 18765 bytes from 
[/opt/online/jails/Afx2rmTrxJDMoZwI/user/docs/Afx2rmTrxJDMoZwI/TPE Y_T.odt] -> 
[https://193.168.56.101:8888/c/common/wopi/files/104174473/contents?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit]:
 500 Erreur Interne de Servlet| wsd/Storage.cpp:661
wsd-08010-11026 11:01:10.548032 [ docbroker_1927 ] ERR  Failed to save docKey 
[193.168.56.101:443/c/common/wopi/files/104174473] to URI 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit].
 Notifying client.| wsd/DocumentBroker.cpp:659
wsd-08010-11026 11:01:10.548083 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.548115 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:10.548130 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.548159 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:10.551784 [ docbrkit-11020-08013 11:01:10.552181 [ loolkit ] DBG  
child_ws_11020: recv [tilecombine part=0 width=256 height=256 
tileposx=0,3840,7680,11520,0,3840,7680,11520,0,3840,7680,11520 
tileposy=15360,15360,15360,15360,19200,19200,19200,19200,23040,23040,23040,23040 
imgsize=0,0,0,0,0,0,0,0,0,0,0,0 tilewidth=3840 tileheight=3840 
ver=1056,1057,1058,1059,1060,1061,1062,1063,1064,1065,1066,1067 
oldhash=6227672625486620356,588219245901538383,8785111039405649441,15311892977825275237,6149479187902473983,10817059262853168842,2888823077240917423,2170911108350901704,15487003055925722276...].|
 kit/Kit.cpp:1947
kit-11020-11028 11:01:10.558382 [ lokit_1927 ] DBG  paintTile (combined) at (0, 15360), (15360, 
11520)  rendered in 3.39 ms (231.986 MP/s).| kit/Kit.cpp:844
kit-11020-11028 11:01:10.559400 [ lokit_1927 ] DBG  renderCombinedTiles at (0, 15360), (15360, 
11520)  took 4.412 ms (including the paintTile).| kit/Kit.cpp:901
kit-11020-08013 11:01:10.804070 [ loolkit ] DBG  child_ws_11020: recv [tile  part=0 width=256 
height=256 tileposx=0 tileposy=11520 tilewidth=3840 tileheight=3840 oldhash=0 hash=0 ver=1068].| 
kit/Kit.cpp:1947
kit-11020-08013 11:01:10.804265 [ loolkit ] DBG  child_ws_11020: recv [tilecombine part=0 width=256 
height=256 tileposx=0,3840,7680,11520 tileposy=26880,26880,26880,26880 imgsize=0,0,0,0 
tilewidth=3840 tileheight=3840 ver=1069,1070,1071,1072 oldhash=0,0,0,0 hash=0,0,0,0].| 
kit/Kit.cpp:1947
kit-11020-11028 11:01:10.806266 [ lokit_1927 ] DBG  PNG cache with hash 11664565580004974293 hit.| 
kit/Kit.cpp:351
oker_1927 ] DBG  Redundant request to subscribe on tile (0,0,15360)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551832 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,3840,15360)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551851 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,7680,15360)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551869 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,11520,15360)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551886 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,0,19200)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551904 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,3840,19200)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551921 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,7680,19200)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551938 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,11520,19200)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551955 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,0,23040)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551974 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,3840,23040)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.551991 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,7680,23040)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.552008 [ docbroker_1927 ] DBG  Redundant request to subscribe on tile 
(0,11520,23040)| wsd/TileCache.cpp:459
wsd-08010-11026 11:01:10.552097 [ docbroker_1927 ] DBG  Sending residual tilecombine: tilecombine 
part=0 width=256 height=256 tileposx=0,3840,7680,11520,0,3840,7680,11520,0,3840,7680,11520 
tileposy=15360,15360,15360,15360,19200,19200,19200,19200,23040,23040,23040,23040 
imgsize=0,0,0,0,0,0,0,0,0,0,0,0 tilewidth=3840 tileheight=3840 
ver=1056,1057,1058,1059,1060,1061,1062,1063,1064,1065,1066,1067 
oldhash=6227672625486620356,588219245901538383,8785111039405649441,15311892977825275237,6149479187902473983,10817059262853168842,2888823077240917423,2170911108350901704,15487003055925722276,12173334279178745396,12173334279178745396,2170911108350901704
 hash=0,0,0,0,0,0,0,0,0,0,0,0| wsd/DocumentBroker.cpp:1133
wsd-08010-11026 11:01:10.559500 [ docbroker_1927 ] DBG  Handling tile combined: tilecombine: part=0 
width=256 height=256 tileposx tileposy imgsize tilewidth=3840 tileheight=3840 ver oldhash hash| 
wsd/DocumentBroker.cpp:1183
wsd-08010-11026 11:01:10.559518 [ docbroker_1927 ] WRN  Dropping empty tilecombine response: 
tilecombine: part=0 width=256 height=256 tileposx tileposy imgsize tilewidth=3840 tileheight=3840 
ver oldhash hash| wsd/DocumentBroker.cpp:1204
wsd-08010-11026 11:01:10.803917 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,0,11520) ver=1068 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:10.803940 [ docbroker_1927 ] DBG  Sending render request for tile 
(0,0,11520).| wsd/DocumentBroker.cpp:1074
wsd-08010-11026 11:01:10.804069 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,0,26880) ver=1069 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:10.804097 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,3840,26880) ver=1070 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:10.804120 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,7680,26880) ver=1071 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:10.804149 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,11520,26880) ver=1072 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:10.804200 [ docbroker_1927 ] DBG  Sending residual tilecombine: tilecombine 
part=0 width=256 height=256 tileposx=0,3840,7680,11520 tileposy=26880,26880,26880,26880 
imgsize=0,0,0,0 tilewidth=3840 tileheight=3840 ver=1069,1070,1071,1072 oldhash=0,0,0,0 
hash=0,0,0,0| wsd/DocumentBroker.cpp:1133
wsd-08010-11026 11:01:10.806474 [ docbroker_1927 ] DBG  Handling tile: tile: part=0 width=256 
height=256 tileposx=0 tkit-11020-11028 11:01:10.807308 [ lokit_1927 ] DBG  paintTile (combined) at 
(0, 26880), (15360, 3840)  rendered in 0.678 ms (386.643 MP/s).| kit/Kit.cpp:844
kit-11020-11028 11:01:10.807380 [ lokit_1927 ] DBG  PNG cache with hash 15487003055925722276 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:10.807448 [ lokit_1927 ] DBG  PNG cache with hash 12173334279178745396 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:10.807497 [ lokit_1927 ] DBG  PNG cache with hash 12173334279178745396 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:10.807544 [ lokit_1927 ] DBG  PNG cache with hash 2170911108350901704 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:10.807557 [ lokit_1927 ] DBG  renderCombinedTiles at (0, 26880), (15360, 
3840)  took 0.929 ms (including the paintTile).| kit/Kit.cpp:901
ileposy=11520 tilewidth=3840 tileheight=3840 oldhash=0 hash=0 ver=1068| wsd/DocumentBroker.cpp:1153
wsd-08010-11026 11:01:10.806667 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,11520.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,11520.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:10.806688 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=0 tileposy=11520 tilewidth=3840 tileheight=3840 
oldhash=0 hash=0 ver=1068| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:10.806728 [ docbroker_1927 ] DBG  STATISTICS: tile 1068 internal roundtrip 2 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:10.806765 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.806835 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:10.807675 [ docbroker_1927 ] DBG  Handling tile combined: tilecombine: part=0 
width=256 height=256 tileposx=0,3840,7680,11520 tileposy=26880,26880,26880,26880 
imgsize=895,854,854,896 tilewidth=3840 tileheight=3840 ver=1069,1070,1071,1072 oldhash=0,0,0,0 
hash=15487003055925722276,12173334279178745396,12173334279178745396,2170911108350901704| 
wsd/DocumentBroker.cpp:1183
wsd-08010-11026 11:01:10.807787 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,26880.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,26880.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:10.807800 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=0 tileposy=26880 tilewidth=3840 tileheight=3840 
oldhash=0 hash=15487003055925722276 ver=1069 imgsize=895| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:10.807825 [ docbroker_1927 ] DBG  STATISTICS: tile 1069 internal roundtrip 3 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:10.807895 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,26880.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,26880.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:10.807906 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=3840 tileposy=26880 tilewidth=3840 tileheight=3840 
oldhash=0 hash=12173334279178745396 ver=1070 imgsize=854| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:10.807931 [ docbroker_1927 ] DBG  STATISTICS: tile 1070 internal roundtrip 3 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:10.807982 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,26880.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,26880.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:10.807995 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=7680 tileposy=26880 tilewidth=3840 tileheight=3840 
oldhash=0 hash=12173334279178745396 ver=1071 imgsize=854| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:10.808037 [ docbroker_1927 ] DBG  STATISTICS: tile 1071 internal roundtrip 3 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:10.808093 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,26880.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,26880.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:10.808102 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=11520 tileposy=26880 tilewidth=3840 tileheight=3840 
oldhash=0 hash=217091110835090kit-11020-08013 11:01:11.561815 [ loolkit ] DBG  child_ws_11020: recv 
[tilecombine part=0 width=256 height=256 tileposx=3840,7680,11520 tileposy=11520,11520,11520 
imgsize=0,0,0 tilewidth=3840 tileheight=3840 ver=1073,1074,1075 oldhash=0,0,0 hash=0,0,0].| 
kit/Kit.cpp:1947
kit-11020-08013 11:01:11.562001 [ loolkit ] DBG  child_ws_11020: recv [tilecombine part=0 width=256 
height=256 tileposx=0,3840 tileposy=30720,30720 imgsize=0,0 tilewidth=3840 tileheight=3840 
ver=1076,1077 oldhash=0,0 hash=0,0].| kit/Kit.cpp:1947
kit-11020-11028 11:01:11.565453 [ lokit_1927 ] DBG  paintTile (combined) at (3840, 11520), (11520, 
3840)  rendered in 2.966 ms (66.2873 MP/s).| kit/Kit.cpp:844
kit-11020-11028 11:01:11.565605 [ lokit_1927 ] DBG  PNG cache with hash 7869085532559473055 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:11.565673 [ lokit_1927 ] DBG  PNG cache with hash 8263747631789812798 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:11.565735 [ lokit_1927 ] DBG  PNG cache with hash 2170911108350901704 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:11.565743 [ lokit_1927 ] DBG  renderCombinedTiles at (3840, 11520), (11520, 
3840)  took 3.261 ms (including the paintTile).| kit/Kit.cpp:901
1704 ver=1072 imgsize=896| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:10.808147 [ docbroker_1927 ] DBG  STATISTICS: tile 1072 internal roundtrip 3 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:10.808173 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.808207 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:10.808231 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.808247 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:10.808254 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.808260 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:10.808265 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:10.808276 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:11.561305 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,3840,11520) ver=1073 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:11.561353 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,7680,11520) ver=1074 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:11.561377 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,11520,11520) ver=1075 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:11.561420 [ docbroker_1927 ] DBG  Sending residual tilecombine: tilecombine 
part=0 width=256 height=256 tileposx=3840,7680,11520 tileposy=11520,11520,11520 imgsize=0,0,0 
tilewidth=3840 tileheight=3840 ver=1073,1074,1075 oldhash=0,0,0 hash=0,0,0| 
wsd/DocumentBroker.cpp:1133
wsd-08010-11026 11:01:11.561645 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,0,30720) ver=1076 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:11.561672 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,3840,30720) ver=1077 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:11.561705 [ docbroker_1927 ] DBG  Sending residual tilecombine: tilecombine 
part=0 width=256 height=256 tileposx=0,3840 tileposy=30720,30720 imgsize=0,0 tilewidth=3840 
tileheight=3840 ver=1076,1077 oldhash=0,0 hash=0,0| wsd/DocumentBroker.cpp:1133
wsd-08010-11026 11:01:11.565875 [ docbroker_1927 ] DBG  Handling tile combined: tilecombine: part=0 
width=256 height=256 tileposx=3840,7680,11520 tileposy=11520,11520,11520 imgsize=12297,6980,896 
tilewidth=3840 tileheight=3840 ver=1073,1074,1075 oldhash=0,0,0 
hash=7869085532559473055,8263747631789812798,2170911108350901704| wsd/DocumentBroker.cpp:1183
wsd-08010-11026 11:01:11.566003 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,11520.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,11520.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:11.566015 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=3840 tileposy=11520 tilewidth=3840 tileheight=3840 
oldhash=0 hash=7869085532559473055 ver=1073 imgsize=12297| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:11.566043 [ docbroker_1927 ] DBG  STATISTICS: tile 1073 internal roundtrip 4 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:11.566095 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,11520.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,11520.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:11.566104 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 widkit-11020-11028 11:01:11.567048 [ lokit_1927 ] DBG  paintTile (combined) at (0, 
30720), (7680, 3840)  rendered in 0.569 ms (230.355 MP/s).| kit/Kit.cpp:844
kit-11020-11028 11:01:11.567127 [ lokit_1927 ] DBG  PNG cache with hash 6676965012320669823 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:11.567186 [ lokit_1927 ] DBG  PNG cache with hash 4310624997278556557 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:11.567194 [ lokit_1927 ] DBG  renderCombinedTiles at (0, 30720), (7680, 3840) 
 took 0.718 ms (including the paintTile).| kit/Kit.cpp:901
th=256 height=256 tileposx=7680 tileposy=11520 tilewidth=3840 tileheight=3840 oldhash=0 
hash=8263747631789812798 ver=1074 imgsize=6980| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:11.566145 [ docbroker_1927 ] DBG  STATISTICS: tile 1074 internal roundtrip 4 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:11.566189 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,11520.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,11520.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:11.566197 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=11520 tileposy=11520 tilewidth=3840 tileheight=3840 
oldhash=0 hash=2170911108350901704 ver=1075 imgsize=896| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:11.566226 [ docbroker_1927 ] DBG  STATISTICS: tile 1075 internal roundtrip 4 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:11.566248 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:11.566297 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:11.566309 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:11.566322 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:11.566329 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:11.566335 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:11.567262 [ docbroker_1927 ] DBG  Handling tile combined: tilecombine: part=0 
width=256 height=256 tileposx=0,3840 tileposy=30720,30720 imgsize=1380,880 tilewidth=3840 
tileheight=3840 ver=1076,1077 oldhash=0,0 hash=6676965012320669823,4310624997278556557| 
wsd/DocumentBroker.cpp:1183
wsd-08010-11026 11:01:11.567349 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,30720.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,30720.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:11.567360 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=0 tileposy=30720 tilewidth=3840 tileheight=3840 
oldhash=0 hash=6676965012320669823 ver=1076 imgsize=1380| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:11.567383 [ docbroker_1927 ] DBG  STATISTICS: tile 1076 internal roundtrip 5 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:11.567430 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,30720.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,30720.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:11.567438 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=3840 tileposy=30720 tilewidth=3840 tileheight=3840 
oldhash=0 hash=4310624997278556557 ver=1077 imgsize=880| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:11.567464 [ docbroker_1927 ] DBG  STATISTICS: tile 1077 internal roundtrip 5 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:11.567482 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:11.567509 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:11.567520 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:11.567528 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:12.309560 [ docbroker_1927 ] DBG  Subscribing ToClienkit-11020-08013 
11:01:12.309843 [ loolkit ] DBG  child_ws_11020: recv [tilecombine part=0 width=256 height=256 
tileposx=0,3840,7680 tileposy=7680,7680,7680 imgsize=0,0,0 tilewidth=3840 tileheight=3840 
ver=1078,1079,1080 oldhash=0,0,0 hash=0,0,0].| kit/Kit.cpp:1947
kit-11020-08013 11:01:12.309967 [ loolkit ] DBG  child_ws_11020: recv [tilecombine part=0 width=256 
height=256 tileposx=7680,11520 tileposy=30720,30720 imgsize=0,0 tilewidth=3840 tileheight=3840 
ver=1081,1082 oldhash=0,0 hash=0,0].| kit/Kit.cpp:1947
kit-11020-11028 11:01:12.315948 [ lokit_1927 ] DBG  paintTile (combined) at (0, 7680), (11520, 
3840)  rendered in 5.527 ms (35.5723 MP/s).| kit/Kit.cpp:844
kit-11020-11028 11:01:12.316040 [ lokit_1927 ] DBG  PNG cache with hash 12402874560350094728 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:12.316103 [ lokit_1927 ] DBG  PNG cache with hash 10944385606576055752 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:12.316163 [ lokit_1927 ] DBG  PNG cache with hash 5022523304132829795 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:12.316174 [ lokit_1927 ] DBG  renderCombinedTiles at (0, 7680), (11520, 3840) 
 took 5.756 ms (including the paintTile).| kit/Kit.cpp:901
t-1f541 to tile (0,0,7680) ver=1078 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:12.309625 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,3840,7680) ver=1079 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:12.309639 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,7680,7680) ver=1080 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:12.309663 [ docbroker_1927 ] DBG  Sending residual tilecombine: tilecombine 
part=0 width=256 height=256 tileposx=0,3840,7680 tileposy=7680,7680,7680 imgsize=0,0,0 
tilewidth=3840 tileheight=3840 ver=1078,1079,1080 oldhash=0,0,0 hash=0,0,0| 
wsd/DocumentBroker.cpp:1133
wsd-08010-11026 11:01:12.309737 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,7680,30720) ver=1081 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:12.309760 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,11520,30720) ver=1082 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:12.309776 [ docbroker_1927 ] DBG  Sending residual tilecombine: tilecombine 
part=0 width=256 height=256 tileposx=7680,11520 tileposy=30720,30720 imgsize=0,0 tilewidth=3840 
tileheight=3840 ver=1081,1082 oldhash=0,0 hash=0,0| wsd/DocumentBroker.cpp:1133
wsd-08010-11026 11:01:12.316389 [ docbroker_1927 ] DBG  Handling tile combined: tilecombine: part=0 
width=256 height=256 tileposx=0,3840,7680 tileposy=7680,7680,7680 imgsize=17115,20061,17038 
tilewidth=3840 tileheight=3840 ver=1078,1079,1080 oldhash=0,0,0 
hash=12402874560350094728,10944385606576055752,5022523304132829795| wsd/DocumentBroker.cpp:1183
wsd-08010-11026 11:01:12.316502 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,7680.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,7680.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:12.316513 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=0 tileposy=7680 tilewidth=3840 tileheight=3840 oldhash=0 
hash=12402874560350094728 ver=1078 imgsize=17115| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:12.316540 [ docbroker_1927 ] DBG  STATISTICS: tile 1078 internal roundtrip 6 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:12.316592 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,7680.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,7680.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:12.316601 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=3840 tileposy=7680 tilewidth=3840 tileheight=3840 
oldhash=0 hash=10944385606576055752 ver=1079 imgsize=20061| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:12.316629 [ docbroker_1927 ] DBG  STATISTICS: tile 1079 internal roundtrip 6 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:12.316679 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,7680.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,7680.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:12.316687 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=7680 tileposy=7680 tilewidth=3840 tileheight=3840 
oldhash=0 hash=5022523304132829795 ver=1080 imgsize=17038| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:12.316721 [ docbroker_1927 ] DBG  STATISTICS: tile 1080 internal roundtrip 7 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:12.316742 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:12.316795 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:12.316807 [ docbroker_1927 ] DBG kit-11020-11028 11:01:12.317512 [ lokit_1927 
] DBG  paintTile (combined) at (7680, 30720), (7680, 3840)  rendered in 0.531 ms (246.84 MP/s).| 
kit/Kit.cpp:844
kit-11020-11028 11:01:12.317582 [ lokit_1927 ] DBG  PNG cache with hash 13088718402022575778 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:12.317634 [ lokit_1927 ] DBG  PNG cache with hash 6198932366493772984 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:12.317642 [ lokit_1927 ] DBG  renderCombinedTiles at (7680, 30720), (7680, 
3840)  took 0.662 ms (including the paintTile).| kit/Kit.cpp:901
kit-11020-08013 11:01:12.654942 [ loolkit ] DBG  child_ws_11020: recv [child-1f541 mouse type=move 
x=6690 y=18915 count=1 buttons=0 modifier=0].| kit/Kit.cpp:1947
kit-11020-08013 11:01:13.068364 [ loolkit ] DBG  child_ws_11020: recv [tilecombine part=0 width=256 
height=256 tileposx=0,3840,7680,11520,11520 tileposy=3840,3840,3840,3840,7680 imgsize=0,0,0,0,0 
tilewidth=3840 tileheight=3840 ver=1083,1084,1085,1086,1087 oldhash=0,0,0,0,0 hash=0,0,0,0,0].| 
kit/Kit.cpp:1947
kit-11020-11028 11:01:13.077010 [ lokit_1927 ] DBG  paintTile (combined) at (0, 3840), (15360, 
7680)  rendered in 7.852 ms (66.7713 MP/s).| kit/Kit.cpp:844
kit-11020-11028 11:01:13.077101 [ lokit_1927 ] DBG  PNG cache with hash 1885249386937985405 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:13.077167 [ lokit_1927 ] DBG  PNG cache with hash 4175472519436499712 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:13.077221 [ lokit_1927 ] DBG  PNG cache with hash 5570104723882240543 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:13.077271 [ lokit_1927 ] DBG  PNG cache with hash 2170911108350901704 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:13.077320 [ lokit_1927 ] DBG  PNG cache with hash 2170911108350901704 hit.| 
kit/Kit.cpp:351
kit-11020-11028 11:01:13.077325 [ lokit_1927 ] DBG  renderCombinedTiles at (0, 3840), (15360, 7680) 
 took 8.17 ms (including the paintTile).| kit/Kit.cpp:901
 ToClient-1f541 ClientSession: performing writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:12.316841 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:12.316849 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:12.316865 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:12.317702 [ docbroker_1927 ] DBG  Handling tile combined: tilecombine: part=0 
width=256 height=256 tileposx=7680,11520 tileposy=30720,30720 imgsize=957,1347 tilewidth=3840 
tileheight=3840 ver=1081,1082 oldhash=0,0 hash=13088718402022575778,6198932366493772984| 
wsd/DocumentBroker.cpp:1183
wsd-08010-11026 11:01:12.317779 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,30720.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,30720.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:12.317789 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=7680 tileposy=30720 tilewidth=3840 tileheight=3840 
oldhash=0 hash=13088718402022575778 ver=1081 imgsize=957| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:12.317809 [ docbroker_1927 ] DBG  STATISTICS: tile 1081 internal roundtrip 8 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:12.317852 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,30720.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,30720.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:12.317860 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=11520 tileposy=30720 tilewidth=3840 tileheight=3840 
oldhash=0 hash=6198932366493772984 ver=1082 imgsize=1347| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:12.317883 [ docbroker_1927 ] DBG  STATISTICS: tile 1082 internal roundtrip 8 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:12.317900 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:12.317924 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:12.317934 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:12.317959 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:13.068080 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,0,3840) ver=1083 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:13.068121 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,3840,3840) ver=1084 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:13.068147 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,7680,3840) ver=1085 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:13.068169 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,11520,3840) ver=1086 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:13.068191 [ docbroker_1927 ] DBG  Subscribing ToClient-1f541 to tile 
(0,11520,7680) ver=1087 which has no subscribers.| wsd/TileCache.cpp:479
wsd-08010-11026 11:01:13.068242 [ docbroker_1927 ] DBG  Sending residual tilecombine: tilecombine 
part=0 width=256 height=256 tileposx=0,3840,7680,11520,11520 tileposy=3840,3840,3840,3840,7680 
imgsize=0,0,0,0,0 tilewidth=3840 tileheight=3840 ver=1083,1084,1085,1086,1087 oldhash=0,0,0,0,0 
hash=0,0,0,0,0| wsd/DocumentBroker.cpp:1133
wsd-08010-11026 11:01:13.077530 [ docbroker_1927 ] DBG  Handling tile combined: tilecombine: part=0 
width=256 height=256 tileposx=0,3840,7680,11520,11520 tileposy=3840,3840,3840,3840,7680 
imgsize=17772,17509,11541,896,896 tilewidth=3840 tileheight=3840 ver=1083,1084,1085,1086,1087 
oldhash=0,0,0,0,0 
hash=1885249386937985405,4175472519436499712,5570104723882240543,2170911108350901704,2170911108350901704|
 wsd/DocumentBroker.cpp:1183
wsd-08010-11026 11:01:13.077672 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,3840.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.0,3840.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:13.077683 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=0 tileposy=3840 tilewidth=3840 tileheight=3840 oldhash=0 
hash=1885249386937985405 ver=1083 imgsize=17772| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:13.077711 [ docbroker_1927 ] DBG  STATISTICS: tile 1083 internal roundtrip 9 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:13.077767 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,3840.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.3840,3840.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:13.077776 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=3840 tileposy=3840 tilewidth=3840 tileheight=3840 
oldhash=0 hash=4175472519436499712 ver=1084 imgsize=17509| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:13.077803 [ docbroker_1927 ] DBG  STATISTICS: tile 1084 internal roundtrip 9 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:13.077845 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,3840.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.7680,3840.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:13.077853 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=7680 tileposy=3840 tilewidth=3840 tileheight=3840 
oldhash=0 hash=5570104723882240543 ver=1085 imgsize=11541| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:13.077880 [ docbroker_1927 ] DBG  STATISTICS: tile 1085 internal roundtrip 9 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:13.077916 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,3840.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,3840.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:13.077924 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=11520 tileposy=3840 tilewidth=3840 tileheight=3840 
oldhash=0 hash=2170911108350901704 ver=1086 imgsize=896| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:13.077952 [ docbroker_1927 ] DBG  STATISTICS: tile 1086 internal roundtrip 9 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:13.077987 [ docbroker_1927 ] DBG  Renaming 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,7680.3840x3840.png.temp
 to 
/usr/local/var/cache/loolwsd/1/b/8/b256deef37bfea4b755dd82fc062c5c53c2fe/0_256x256.11520,7680.3840x3840.png
 OK.| common/FileUtil.cpp:105
wsd-08010-11026 11:01:13.077994 [ docbroker_1927 ] DBG  Sending tile message to 1 subscribers: 
tile: part=0 width=256 height=256 tileposx=11520 tileposy=7680 tilewidth=3840 tileheight=3840 
oldhash=0 hash=2170911108350901704 ver=1087 imgsize=896| wsd/TileCache.cpp:175
wsd-08010-11026 11:01:13.078027 [ docbroker_1927 ] DBG  STATISTICS: tile 1087 internal roundtrip 9 
ms.| wsd/TileCache.cpp:221
wsd-08010-11026 11:01:13.078055 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:13.078107 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:13.078117 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSkit-11020-08013 
11:01:13.177385 [ loolkit ] DBG  child_ws_11020: recv [child-1f541 uno .uno:Save 
{"DontTerminateEdit":{"type":"boolean","value":true},"DontSaveIfUnmodified":{"type":"boolean","value":true}}].|
 kit/Kit.cpp:1947
ession: performing writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:13.078149 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:13.078157 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:13.078174 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:13.078180 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:13.078185 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:13.078190 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performing 
writes| wsd/ClientSession.cpp:492
wsd-08010-11026 11:01:13.078195 [ docbroker_1927 ] DBG  ToClient-1f541 ClientSession: performed 
write| wsd/ClientSession.cpp:516
wsd-08010-11026 11:01:13.176972 [ docbroker_1927 ] DBG  SslStreamSocket::closeConnection() #23| 
./net/SslSocket.hpp:67
wsd-08010-11026 11:01:13.177051 [ docbroker_1927 ] ERR  Socket #23 SSL BIO error: closed (0).| 
./net/SslSocket.hpp:255
wsd-08010-11026 11:01:13.177068 [ docbroker_1927 ] INF  ToClient-1f541 Disconnected, current number 
of connections: 3| wsd/ClientSession.cpp:779
wsd-08010-11026 11:01:13.177076 [ docbroker_1927 ] DBG  ToClient-1f541 on docKey 
[193.168.56.101:443/c/common/wopi/files/104174473] terminated. Cleaning up.| 
wsd/ClientSession.cpp:789
wsd-08010-11026 11:01:13.177085 [ docbroker_1927 ] DBG  startDestroy on session [1f541] on docKey 
[193.168.56.101:443/c/common/wopi/files/104174473], sessions: 1 markToDestroy: true, 
lastEditableSession: true| wsd/DocumentBroker.cpp:1247
wsd-08010-11026 11:01:13.177092 [ docbroker_1927 ] INF  Removing session [1f541] on docKey 
[193.168.56.101:443/c/common/wopi/files/104174473]. Have 1 sessions. markToDestroy: true, 
LastEditableSession: true| wsd/DocumentBroker.cpp:881
wsd-08010-11026 11:01:13.177104 [ docbroker_1927 ] INF  Saving doc 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:740
wsd-08010-11026 11:01:13.177162 [ docbroker_1927 ] ERR  Socket #23 SSL BIO error: 
error:140D00CF:SSL routines:SSL_write:protocol is shutdown (errno: Success)| ./net/SslSocket.hpp:273
wsd-08010-11026 11:01:13.177241 [ docbroker_1927 ] WRN  ToClient-1f541: Exception while closing 
socket for docKey [193.168.56.101:443/c/common/wopi/files/104174473]: error:140D00CF:SSL 
routines:SSL_write:protocol is shutdown| wsd/ClientSession.cpp:833
wsd-08010-11026 11:01:13.177250 [ docbroker_1927 ] DBG  Removing socket #23 (of 2) from 
docbroker_1927| ./net/Socket.hpp:481
wsd-08010-11026 11:01:13.177258 [ docbroker_1927 ] DBG  SslStreamSocket dtor #23| 
./net/SslSocket.hpp:53
wsd-08010-11026 11:01:13.177264 [ docbroker_1927 ] DBG  SslStreamSocket::closeConnection() #23| 
./net/SslSocket.hpp:67
wsd-08010-11026 11:01:13.177305 [ docbroker_1927 ] DBG  StreamSocket dtor #23| ./net/Socket.hpp:697
wsd-08010-11026 11:01:13.177727 [ docbroker_1927 ] INF  ToClient-1f541: Command: unocommandresult: {
    "commandName": ".uno:Save",
    "success": "false",
    "result": {
        "type": "string",
        "value": "unmodified"
    }
}
| wsd/ClientSession.cpp:539
wsd-08010-11026 11:01:13.177786 [ docbroker_1927 ] DBG  Save skipped as document 
[193.168.56.101:443/c/common/wopi/files/104174473] was not modified.| wsd/DocumentBroker.cpp:574
wsd-08010-11026 11:01:13.178001 [ docbroker_1927 ] INF  ~ClientSession dtor [ToClient-1f541], 
current number of connections: 2| wsd/ClientSession.cpp:50
wsd-08010-11026 11:01:13.178038 [ docbroker_1927 ] INF  Terminating dead DocumentBroker for docKey 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:261
wsd-08010-11026 11:01:13.178048 [ docbroker_1927 ] INF  Finished polling doc 
[193.168.56.101:443/c/common/wopi/files/104174473]. stop: true, continuePolling: true, 
ShutdownRequestFlag: false, Terminatkit-11020-08013 11:01:13.178159 [ loolkit ] DBG  
child_ws_11020: recv [child-1f541 disconnect].| kit/Kit.cpp:1947
kit-11020-11028 11:01:13.178210 [ lokit_1927 ] DBG  Removing ChildSession [1f541].| kit/Kit.cpp:1434
kit-11020-11028 11:01:13.178225 [ lokit_1927 ] DBG  Have 0 children after removing ChildSession 
[1f541].| kit/Kit.cpp:1438
kit-11020-11028 11:01:13.178237 [ lokit_1927 ] INF  ~ChildSession dtor [ToMaster-1f541].| 
kit/ChildSession.cpp:52
kit-11020-11028 11:01:13.178248 [ lokit_1927 ] INF  Unloading session [1f541] on url 
[193.168.56.101:443/c/common/wopi/files/104174473].| kit/Kit.cpp:1107
kit-11020-11028 11:01:13.178345 [ lokit_1927 ] INF  Document 
[193.168.56.101:443/c/common/wopi/files/104174473] has no more views, exiting bluntly.| 
kit/Kit.cpp:1128
frk-08013-08013 11:01:13.356265 [ forkit ] INF  Child 11020 has exited, removing its jail 
'/opt/online/jails/Afx2rmTrxJDMoZwI'.| kit/ForKit.cpp:202
ionFlag: false.| wsd/DocumentBroker.cpp:269
wsd-08010-11026 11:01:13.185160 [ docbroker_1927 ] DBG  Removing socket #26 (of 1) from 
docbroker_1927| ./net/Socket.hpp:481
wsd-08010-11026 11:01:13.185183 [ docbroker_1927 ] INF  Terminating doc 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:1388
wsd-08010-11026 11:01:13.185191 [ docbroker_1927 ] INF  Terminating 0 clients of doc 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:1346
wsd-08010-11026 11:01:13.185198 [ docbroker_1927 ] INF  Terminating child [11020] of doc 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:1395
wsd-08010-11026 11:01:13.185207 [ docbroker_1927 ] DBG  Stopping ChildProcess [11020]| 
wsd/DocumentBroker.hpp:102
wsd-08010-11026 11:01:13.185258 [ docbroker_1927 ] DBG  Closing ChildProcess [11020].| 
wsd/DocumentBroker.hpp:119
wsd-08010-11026 11:01:13.185263 [ docbroker_1927 ] DBG  Stopping ChildProcess [11020]| 
wsd/DocumentBroker.hpp:102
wsd-08010-11026 11:01:13.185268 [ docbroker_1927 ] ERR  #26: Wrote outgoing data -1 bytes. (errno: 
Broken pipe)| ./net/Socket.hpp:909
wsd-08010-11026 11:01:13.185278 [ docbroker_1927 ] ERR  #26: Wrote outgoing data -1 bytes. (errno: 
Broken pipe)| ./net/Socket.hpp:909
wsd-08010-11026 11:01:13.185282 [ docbroker_1927 ] DBG  Stopping docbroker_1927.| 
./net/Socket.hpp:327
wsd-08010-11026 11:01:13.185286 [ docbroker_1927 ] DBG  Removing all sockets from docbroker_1927.| 
./net/Socket.hpp:334
wsd-08010-11026 11:01:13.185293 [ docbroker_1927 ] INF  Finished docBroker polling thread for 
docKey [193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:298
wsd-08010-08012 11:01:13.185332 [ prisoner_poll ] INF  Removing DocumentBroker for docKey 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/LOOLWSD.cpp:239
wsd-08010-08012 11:01:13.185341 [ prisoner_poll ] INF  Removing complete doc 
[193.168.56.101:443/c/common/wopi/files/104174473] from Admin.| wsd/Admin.cpp:381
wsd-08010-08012 11:01:13.185349 [ prisoner_poll ] INF  ~DocumentBroker 
[193.168.56.101:443/c/common/wopi/files/104174473] destroyed with 0 sessions left.| 
wsd/DocumentBroker.cpp:317
wsd-08010-08012 11:01:13.185354 [ prisoner_poll ] WRN  Waking up dead poll thread [docbroker_1927], 
started: true, finished: true| ./net/Socket.hpp:507
wsd-08010-08012 11:01:13.185358 [ prisoner_poll ] DBG  Stopping docbroker_1927.| net/Socket.hpp:327
wsd-08010-08012 11:01:13.185361 [ prisoner_poll ] WRN  Waking up dead poll thread [docbroker_1927], 
started: true, finished: true| ./net/Socket.hpp:507
wsd-08010-08012 11:01:13.185367 [ prisoner_poll ] DBG  StreamSocket dtor #26| ./net/Socket.hpp:697
wsd-08010-08012 11:01:13.185381 [ prisoner_poll ] WRN  Waking up dead poll thread [docbroker_1927], 
started: false, finished: true| ./net/Socket.hpp:507
wsd-08010-08012 11:01:13.185384 [ prisoner_poll ] DBG  Stopping docbroker_1927.| net/Socket.hpp:327
wsd-08010-08012 11:01:13.185387 [ prisoner_poll ] WRN  Waking up dead poll thread [docbroker_1927], 
started: false, finished: true| ./net/Socket.hpp:507
wsd-08010-08012 11:01:13.185394 [ prisoner_poll ] INF  ~TileCache dtor for uri 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit].|
 wsd/TileCache.cpp:76
wsd-08010-08019 11:01:13.974938 [ accept_poll ] DBG  Accepted socket #23, creating socket object.| 
net/ServerSocket.hpp:69
wsd-08010-08019 11:01:13.974982 [ accept_poll ] DBG  #23 Thread affinity set to 0x7f37dffff700.| 
./net/Socket.hpp:282
wsd-08010-08019 11:01:13.974993 [ accept_poll ] DBG  StreamSocket ctor #23| ./net/Socket.hpp:688
wsd-08010-08019 11:01:13.974999 [ accept_poll ] DBG  SslStreamSocket ctor #23| 
./net/SslSocket.hpp:28
wsd-08010-08019 11:01:13.975038 [ accept_poll ] DBG  Accepted client #23| net/ServerSocket.hpp:104
wsd-08010-08019 11:01:13.975043 [ accept_poll ] DBG  Inserting socket #23 into websrv_poll| 
net/Socket.hpp:522
wsd-08010-08019 11:01:13.975047 [ accept_poll ] DBG  #23 Thread affinity set to 0xthread::id of a 
non-executing thread (was 0x7f37dffff700).| ./net/Socket.hpp:241
wsd-08010-08020 11:01:13.975109 [ websrv_poll ] DBG  #23 Thread affinity set to 0x7f37df7fe700 (was 
0xthread::id of a non-executing thread).| ./net/Socket.hpp:241
wsd-08010-08020 11:01:13.977767 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977785 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977792 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977798 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977804 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977813 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977823 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977834 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977844 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977849 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977855 [ websrv_poll ] DBG  #23 doesn't have enough data yet.| 
wsd/LOOLWSD.cpp:1586
wsd-08010-08020 11:01:13.977911 [ websrv_poll ] INF  #23: Client HTTP Request: GET 
/lool/https%3A%2F%2F193.168.56.101%2Fc%2Fcommon%2Fwopi%2Ffiles%2F104174473%3Faccess_token%3D0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74%26access_token_ttl%3D0%26permission%3Dedit/ws
 HTTP/1.1 / Host: 193.168.56.101 / User-Agent: Mozilla/5.0 (Windows NT 10.0; WOW64; rv:52.0) 
Gecko/20100101 Firefox/52.0 / Accept: 
text/html,application/xhtml+xml,application/xml;q=0.9,*/*;q=0.8 / Accept-Language: 
fr,fr-FR;q=0.8,en-US;q=0.5,en;q=0.3 / Accept-Encoding: gzip, deflate, br / Sec-WebSocket-Version: 
13 / Origin: https://193.168.56.101 / Sec-WebSocket-Extensions: permessage-deflate / 
Sec-WebSocket-Key: G8q0aabutDQ7V1T31LqUeA== / Cookie: GUEST_LANGUAGE_ID=fr_FR; COOKIE_SUPPORT=true; 
__utma=232732160.1943395577.1511256014.1511786394.1511860488.5; 
__utmz=232732160.1511256014.1.1.utmcsr=(direct)|utmccn=(direct)|utmcmd=(none); 
_pk_id.1.8b36=89cdaad7b1b7e31b.1511256015.7.1511866225.1511862747.; 
JSESSIONID=12335CCE2B11663C7177B07ADEA32D12.nodeLR1; LFR_SESSION_STATE_75429442=1511866220016; 
__utmb=232732160.214.9.1511866882001; __utmc=232732160; 
_shibsession_64656661756c7468747470733a2f2f6e65726f2e6c2d6564756364656e6f726d616e6469652e6672=_5347261cf9a9260e3387baec0bcca664;
 
_pk_cvar.1.8b36=%7B%221%22%3A%5B%22id_user%22%2C%2275429442%22%5D%2C%222%22%3A%5B%22id_profil%22%2C%221%22%5D%2C%223%22%3A%5B%22id_etab%22%2C%2275419440%22%5D%7D;
 _pk_ses.1.8b36=* / Pragma: no-cache / Cache-Control: no-cache / Shib-Cookie-Name:  / 
Shib-Session-ID: _5347261cf9a9260e3387baec0bcca664 / Shib-Session-Index: 
f6f179e5d416b8f5223f19e65e4a94df / Shib-Identity-Provider: urn:fi:ac-rouen:ts-EDUC-Normandie:1:0 / 
Shib-Authentication-Method: urn:oasis:names:tc:SAML:2.0:ac:classes:PasswordProtectedTransport / 
Shib-Authentication-Instant: 2017-11-28T10:46:02Z / Shib-AuthnContext-Class: 
urn:oasis:names:tc:SAML:2.0:ac:classes:PasswordProtectedTransport / Shib-AuthnContext-Decl:  / 
Shib-Assertion-Count:  / eppn:  / affiliation:  / unscoped-affiliation:  / entitlement:  / 
targeted-id:  / persistent-id:  / FrEduVecteur: 4|||1127464|0760030V / mail: 
tiarci.younes@gmail.com / ENTPersonJointure:  / displayName:  / Shib-Application-ID: default / 
REMOTE_USER: tiarci.younes@gmail.com / ENT_PORTEUR: DEMO / X-Forwarded-For: 194.214.0.101 / 
X-Forwarded-Host: 193.168.56.101 / X-Forwarded-Server: 193.168.56.101 / Upgrade: WebSocket / 
Connection: Upgradewsd/LOOLWSD.cpp:1612
wsd-08010-08020 11:01:13.977951 [ websrv_poll ] INF  Client WS request: 
/lool/https%3A%2F%2F193.168.56.101%2Fc%2Fcommon%2Fwopi%2Ffiles%2F104174473%3Faccess_token%3D0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74%26access_token_ttl%3D0%26permission%3Dedit/ws,
 url: 
https%3A%2F%2F193.168.56.101%2Fc%2Fcommon%2Fwopi%2Ffiles%2F104174473%3Faccess_token%3D0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74%26access_token_ttl%3D0%26permission%3Dedit,
 socket #23| wsd/LOOLWSD.cpp:2049
wsd-08010-08020 11:01:13.977983 [ websrv_poll ] INF  #23: WebSocket version: 13, key: 
[G8q0aabutDQ7V1T31LqUeA==], protocol: [chat].| ./net/WebSocketHandler.hpp:416
wsd-08010-08020 11:01:13.978022 [ websrv_poll ] INF  Starting GET request handler for session 
[1f60d] on url 
[https%3A%2F%2F193.168.56.101%2Fc%2Fcommon%2Fwopi%2Ffiles%2F104174473%3Faccess_token%3D0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74%26access_token_ttl%3D0%26permission%3Dedit].|
 wsd/LOOLWSD.cpp:2064
wsd-08010-08020 11:01:13.978052 [ websrv_poll ] INF  Sanitized URI 
[https%3A%2F%2F193.168.56.101%2Fc%2Fcommon%2Fwopi%2Ffiles%2F104174473%3Faccess_token%3D0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74%26access_token_ttl%3D0%26permission%3Dedit]
 to 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit]
 and mapped to docKey [193.168.56.101:443/c/common/wopi/files/104174473] for session [1f60d].| 
wsd/LOOLWSD.cpp:2074
wsd-08010-08020 11:01:13.978066 [ websrv_poll ] DBG  Query param: access_token, value: 
0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74| wsd/LOOLWSD.cpp:2080
wsd-08010-08020 11:01:13.978071 [ websrv_poll ] DBG  Query param: access_token_ttl, value: 0| 
wsd/LOOLWSD.cpp:2080
wsd-08010-08020 11:01:13.978076 [ websrv_poll ] DBG  Query param: permission, value: edit| 
wsd/LOOLWSD.cpp:2080
wsd-08010-08020 11:01:13.978080 [ websrv_poll ] INF  URL 
[https%3A%2F%2F193.168.56.101%2Fc%2Fcommon%2Fwopi%2Ffiles%2F104174473%3Faccess_token%3D0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74%26access_token_ttl%3D0%26permission%3Dedit]
 is writable.| wsd/LOOLWSD.cpp:2087
wsd-08010-08020 11:01:13.978085 [ websrv_poll ] INF  Find or create DocBroker for docKey 
[193.168.56.101:443/c/common/wopi/files/104174473] for session [1f60d] on url 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit].|
 wsd/LOOLWSD.cpp:1247
wsd-08010-08020 11:01:13.978095 [ websrv_poll ] DBG  No DocumentBroker with docKey 
[193.168.56.101:443/c/common/wopi/files/104174473] found. New Child and Document.| 
wsd/LOOLWSD.cpp:1280
wsd-08010-08020 11:01:13.978113 [ websrv_poll ] DBG  New DocumentBroker for docKey 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/LOOLWSD.cpp:1307
wsd-08010-08020 11:01:13.978133 [ websrv_poll ] INF  DocumentBroker 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit]
 created with docKey [193.168.56.101:443/c/common/wopi/files/104174473] and root 
[/opt/online/jails/]| wsd/DocumentBroker.cpp:168
wsd-08010-08020 11:01:13.978150 [ websrv_poll ] INF  ClientSession ctor [ToClient-1f60d], current 
number of connections: 3| wsd/ClientSession.cpp:44
wsd-08010-08020 11:01:13.978161 [ websrv_poll ] DBG  Removing socket #23 (of 1) from websrv_poll| 
./net/Socket.hpp:481
wsd-08010-08020 11:01:13.978165 [ websrv_poll ] DBG  #23 Thread affinity set to 0xthread::id of a 
non-executing thread (was 0x7f37df7fe700).| ./net/Socket.hpp:241
wsd-08010-11093 11:01:13.978217 [ docbroker_192f ] INF  Thread 11093 (0x7f37dd5df700) is now called 
[docbroker_192f].| common/Util.cpp:325
wsd-08010-11093 11:01:13.978239 [ docbroker_192f ] INF  Starting polling thread [docbroker_192f].| 
net/Socket.hpp:601
wsd-08010-11093 11:01:13.978246 [ docbroker_192f ] DBG  Thread affinity of docbroker_192f set to 
0x7f37dd5df700.| net/Socket.hpp:605
wsd-08010-11093 11:01:13.978254 [ docbroker_192f ] INF  Starting docBroker polling thread for 
docKey [193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:184
wsd-08010-11frk-08013-08013 11:01:13.978326 [ forkit ] INF  ForKit command: [spawn 1].| 
kit/ForKit.cpp:98
frk-08013-08013 11:01:13.978363 [ forkit ] INF  Setting to spawn 1 child per request.| 
kit/ForKit.cpp:106
frk-08013-08013 11:01:13.978372 [ forkit ] INF  Spawning 1 new child.| kit/ForKit.cpp:301
frk-08013-08013 11:01:13.978413 [ forkit ] DBG  Forking a loolkit process with jailId: 
cDFTou32a96ttKkx.| kit/ForKit.cpp:228
frk-08013-08013 11:01:13.980721 [ forkit ] INF  Forked kit [11094].| kit/ForKit.cpp:269
frk-08013-08013 11:01:13.981095 [ loolkit ] INF  Thread 8013 (0x7fbd61379740) is now called 
[loolkit].| common/Util.cpp:325
kit-11094-08013 11:01:13.981326 [ loolkit ] INF  Initializing kit. Local time: Tue 2017-11-28 
12:01:13+0100. Log level is [7].| common/Log.cpp:205
kit-11094-08013 11:01:13.981355 [ loolkit ] DBG  Process started.| kit/Kit.cpp:1751
kit-11094-08013 11:01:13.981402 [ loolkit ] INF  Jail path: /opt/online/jails/cDFTou32a96ttKkx/| 
kit/Kit.cpp:1765
kit-11094-08013 11:01:13.981561 [ loolkit ] DBG  
symlink("../../lo","/opt/online/jails/cDFTou32a96ttKkx/opt/libreoffice/instdir")| kit/Kit.cpp:269
093 11:01:13.978262 [ docbroker_192f ] DBG  getNewChild: Rebalancing children.| wsd/LOOLWSD.cpp:392
wsd-08010-11093 11:01:13.978293 [ docbroker_192f ] DBG  prespawnChildren: Have 1 spare child, and 0 
outstanding, forking 1 more.| wsd/LOOLWSD.cpp:350
wsd-08010-11093 11:01:13.978301 [ docbroker_192f ] DBG  MasterToForKit: spawn 1| wsd/LOOLWSD.cpp:283
wsd-08010-11093 11:01:13.979625 [ docbroker_192f ] DBG  getNewChild: Have 0 spare children after 
poping [11087] to return in 1ms.| wsd/LOOLWSD.cpp:426
wsd-08010-11093 11:01:13.979651 [ docbroker_192f ] DBG  Inserting socket #30 into docbroker_192f| 
./net/Socket.hpp:522
wsd-08010-11093 11:01:13.979665 [ docbroker_192f ] INF  Doc 
[193.168.56.101:443/c/common/wopi/files/104174473] attached to child [11087].| 
wsd/DocumentBroker.cpp:220
wsd-08010-11093 11:01:13.979680 [ docbroker_192f ] DBG  #30 Thread affinity set to 0x7f37dd5df700 
(was 0xthread::id of a non-executing thread).| ./net/Socket.hpp:241
wsd-08010-11093 11:01:13.979689 [ docbroker_192f ] DBG  Socket #23 handler is ToClient-1f60d| 
wsd/LOOLWSD.cpp:2114
wsd-08010-11093 11:01:13.979695 [ docbroker_192f ] DBG  Inserting socket #23 into docbroker_192f| 
./net/Socket.hpp:522
wsd-08010-11093 11:01:13.979704 [ docbroker_192f ] INF  Loading 
[193.168.56.101:443/c/common/wopi/files/104174473] for session [1f60d] and jail 
[p60usZyDxkcKOFtP].| wsd/DocumentBroker.cpp:349
wsd-08010-11093 11:01:13.979724 [ docbroker_192f ] INF  jailPath: /user/docs/p60usZyDxkcKOFtP, 
jailRoot: /opt/online/jails/p60usZyDxkcKOFtP| wsd/DocumentBroker.cpp:373
wsd-08010-11093 11:01:13.979731 [ docbroker_192f ] DBG  Loading, and creating new storage instance 
for URI 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit].|
 wsd/DocumentBroker.cpp:381
wsd-08010-11093 11:01:13.979745 [ docbroker_192f ] INF  Public URI 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit]
 considered WOPI.| wsd/Storage.cpp:203
wsd-08010-11093 11:01:13.979784 [ docbroker_192f ] DBG  Storage ctor: 
https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit|
 wsd/Storage.hpp:76
wsd-08010-11093 11:01:13.979793 [ docbroker_192f ] INF  WopiStorage ctor with localStorePath: 
[/opt/online/jails/p60usZyDxkcKOFtP], jailPath: [/user/docs/p60usZyDxkcKOFtP], uri: 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit].|
 wsd/Storage.hpp:186
wsd-08010-11093 11:01:13.979820 [ docbroker_192f ] DBG  Getting info for wopi uri 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit].|
 wsd/Storage.cpp:435
wsd-08010-11093 11:01:13.997445 [ docbroker_192f ] ERR  WOPI::CheckFileInfo failed with 500 Erreur 
Interne de Servlet| wsd/Storage.cpp:467
wsd-08010-11093 11:01:13.997730 [ docbroker_192f ] ERR  Failed to add session to 
[193.168.56.101:443/c/common/wopi/files/104174473] with URI 
[https://193.168.56.101:8888/c/common/wopi/files/104174473?access_token=0b23c7b5-fc0d-4a4f-a863-1638ebdd5a74&access_token_ttl=0&permission=edit]:
 WOPI::CheckFileInfo failed| wsd/DocumentBroker.cpp:806
wsd-08010-11093 11:01:13.997784 [ docbroker_192f ] INF  Doc 
[193.168.56.101:443/c/common/wopi/files/104174473] has no more sessions. Marking to destroy.| 
wsd/DocumentBroker.cpp:809
wsd-08010-11093 11:01:13.997838 [ docbroker_192f ] INF  Terminating idle DocumentBroker for docKey 
[193.168.56.101:443/c/common/wopi/files/104174473].| wsd/DocumentBroker.cpp:261
wsd-08010-11093 11:01:13.997848 [ docbroker_192f ] INF  Finished polling doc 
[193.168.56.101:443/c/common/wopi/files/104174473]. stop: true, continuePolling: true, 
ShutdownRequestFlag: false, TerminationFlag: false.| wsd/DocumentBroker.cpp:269
wsd-kit-11094-08013 11:01:14.056025 [ loolkit ] DBG  Initialized jail files.| kit/Kit.cpp:1822
kit-11094-08013 11:01:14.056126 [ loolkit ] INF  chroot("/opt/online/jails/cDFTou32a96ttKkx/")| 
kit/Kit.cpp:1846
kit-11094-08013 11:01:14.056173 [ loolkit ] DBG  Initialized jail nodes, dropped caps.| 
kit/Kit.cpp:1863
kit-11094-08013 11:01:14.067180 [ loolkit ] INF  Process is ready.| kit/Kit.cpp:1905
kit-11094-08013 11:01:14.067266 [ loolkit ] DBG  Connecting to Master 127.0.0.1:9981| 
kit/Kit.cpp:1926
kit-11094-08013 11:01:24.067693 [ loolkit ] ERR  Poco Exception: Timeout| kit/Kit.cpp:2038
kit-11094-08013 11:01:24.069471 [ loolkit ] INF  Process finished.| kit/Kit.cpp:2047
frk-08013-08013 11:01:24.492685 [ forkit ] INF  Child 11094 has exited, removing its jail 
'/opt/online/jails/cDFTou32a96ttKkx'.| kit/ForKit.cpp:202
kit-10995-08013 11:01:45.994958 [ loolkit ] ERR  SocketProcessor [child_ws_10995]: Exception: 
Connection reset by peer| common/IoUtil.cpp:170
kit-10995-08013 11:01:45.995020 [ loolkit ] INF  SocketProcessor [child_ws_10995] finished. stop: 
false, n: -1, payload size: 65536, flags: 81| common/IoUtil.cpp:b7
kit-10995-08013 11:01:45.995063 [ loolkit ] INF  Process finished.| kit/Kit.cpp:2047
kit-11087-08013 11:01:45.995259 [ loolkit ] WRN  SocketProcessor [child_ws_11087]: Connection 
closed.| common/IoUtil.cpp:104
frk-08013-08013 11:01:45.995268 [ forkit ] FTL  Pipe closed.| common/IoUtil.cpp:309
kit-11087-08013 11:01:45.995314 [ loolkit ] INF  SocketProcessor [child_ws_11087] finished. stop: 
false, n: 0, payload size: 0, flags: 0| common/IoUtil.cpp:b7
frk-08013-08013 11:01:45.995319 [ forkit ] INF  Child dispatcher flagged for termination.| 
kit/ForKit.cpp:497
frk-08013-08013 11:01:45.995341 [ forkit ] INF  ForKit process finished.| kit/ForKit.cpp:512
kit-11087-08013 11:01:45.995374 [ loolkit ] INF  Process finished.| kit/Kit.cpp:2047


Context


Privacy Policy | Impressum (Legal Info) | Copyright information: Unless otherwise specified, all text and images on this website are licensed under the Creative Commons Attribution-Share Alike 3.0 License. This does not include the source code of LibreOffice, which is licensed under the Mozilla Public License (MPLv2). "LibreOffice" and "The Document Foundation" are registered trademarks of their corresponding registered owners or are in actual use as trademarks in one or more countries. Their respective logos and icons are also subject to international copyright laws. Use thereof is explained in our trademark policy.