[solved] Collabora document editing no longer possible after update

Hi there,

I am running Nextcloud 15.0.5 with Collabora Office 6.0-26 and LOOLWSD 4.0.2 on Ubuntu 16.04.
After regular update yesterday quite a bunch was screwed up in my system.
Virtualbox, Nexcloud, apache and some other things stopped working.

I fiddled around and got everything working again except document editing with collabora.
The document is opening within collabora, but as soon as i start typing it says user disconnected and reconnects the user instantly, but editing is not possible.

Any idea where to look and how to solve this issue.

EDIT: I attached some logging from the apache when things are going wrong:
2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:04 +0100] “GET /index.php/apps/richdocuments/index?fileId=94256121&requesttoken=DDIOXly9TR0Ozfu9Q%2BE%2F2XwkYVsyOylSqhxQXfHdfgk%3D%3AaQAlEjjHF1Fc%2B5SFKpBx4DQTUnQAbBg%2Bn30HLd7uJFs%3D HTTP/1.1” 200 5109 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:04 +0100] “GET /index.php/apps/richdocuments/settings/check HTTP/1.1” 200 1200 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:04 +0100] “GET /ocs/v2.php/apps/notifications/api/v2/notifications HTTP/1.1” 200 860 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:04 +0100] “PROPFIND /remote.php/dav/files/stefan/ HTTP/1.1” 207 9921 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:04 +0100] “GET /index.php/apps/files/ajax/getstoragestats.php?dir=%2F HTTP/1.1” 200 1277 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

2a02:908:8a9:4260:921b:eff:fe9f:a15f - - [16/Mar/2019:22:41:05 +0100] “GET /index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194?access_token=YaXn1YrQgi1xD4GbjINA28UuP5D8dB0l&access_token_ttl=0&permission=edit HTTP/1.1” 200 5128 “-” “LOOLWSD WOPI Agent 4.0.2”

2a02:908:8a9:4260:921b:eff:fe9f:a15f - - [16/Mar/2019:22:41:05 +0100] “GET /index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194/contents?access_token=YaXn1YrQgi1xD4GbjINA28UuP5D8dB0l&access_token_ttl=0&permission=edit HTTP/1.1” 200 12664 “-” “LOOLWSD WOPI Agent 4.0.2”

2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:13 +0100] “GET /ocs/v2.php/apps/notifications/api/v2/notifications HTTP/1.1” 200 1013 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:34 +0100] “GET /ocs/v2.php/apps/notifications/api/v2/notifications HTTP/1.1” 200 1013 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

2a02:908:8a9:4260:921b:eff:fe9f:a15f - - [16/Mar/2019:22:41:36 +0100] “GET /index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194?access_token=YaXn1YrQgi1xD4GbjINA28UuP5D8dB0l&access_token_ttl=0&permission=edit HTTP/1.1” 200 5128 “-” “LOOLWSD WOPI Agent 4.0.2”

2a02:908:8a9:4260:921b:eff:fe9f:a15f - - [16/Mar/2019:22:41:36 +0100] “GET /index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194/contents?access_token=YaXn1YrQgi1xD4GbjINA28UuP5D8dB0l&access_token_ttl=0&permission=edit HTTP/1.1” 200 12674 “-” “LOOLWSD WOPI Agent 4.0.2”

2a02:908:8a9:4260:45c7:ed70:287b:6094 - - [16/Mar/2019:22:41:43 +0100] “GET /ocs/v2.php/apps/notifications/api/v2/notifications HTTP/1.1” 200 1013 “-” “Mozilla/5.0 (Macintosh; Intel Mac OS X 10_14_4) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”

Thanks in advance, Stefan.

Hi -

Hmm its really hard to know based on your posted logs. They don’t actually contain any error messages that I can find. Can you post other logs perhaps?

Hi kevdog,

which log files would help?
I attached nexlcoud.log file with loglevel = 0.

nexcloud.log:
{“reqId”:“SuJSjiIbCyPmPfmxooQ3”,“level”:0,“time”:“2019-03-17T09:16:20+00:00”,“remoteAddr”:“2a02:908:8a9:4260:29ab:e01e:6c16:d170”,“user”:“stefan”,“app”:“no app in context”,“method”:“GET”,“url”:"/index.php/apps/richdocuments/index?fileId=94256121&requesttoken=%2FC9a13NGvrIZc5pGtOuC8FeOgv%2F%2FLUoUuohrBpCqGZY%3D%3ArGw%2FsgkjzopBBN0cxanQlj%2FI67LQTwBi0MkbMfPLe8I%3D",“message”:“No cache entry found for /appdata_ocddt7r4b194/theming/images/background (storage: local::/media/sde1/home/nextcloud_data/, internalPath: appdata_ocddt7r4b194/theming/images/background)”,“userAgent”:“Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”,“version”:“15.0.5.3”}
{“reqId”:“nyy553GUl8LzeXJjnElL”,“level”:0,“time”:“2019-03-17T09:16:20+00:00”,“remoteAddr”:“2a02:908:8a9:4260:29ab:e01e:6c16:d170”,“user”:“stefan”,“app”:“no app in context”,“method”:“GET”,“url”:"/index.php/core/preview?fileId=94256121&c=21e9823ac2171e5785bb778a15323d8e&x=250&y=250&forceIcon=0",“message”:“No cache entry found for /appdata_ocddt7r4b194/preview/94256121 (storage: local::/media/sde1/home/nextcloud_data/, internalPath: appdata_ocddt7r4b194/preview/94256121)”,“userAgent”:“Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/72.0.3626.121 Safari/537.36”,“version”:“15.0.5.3”}
{“reqId”:“Yq6QsSk7nSVdMGimcxwy”,“level”:0,“time”:“2019-03-17T09:16:21+00:00”,“remoteAddr”:“2a02:908:8a9:4260:921b:eff:fe9f:a15f”,“user”:"–",“app”:“richdocuments”,“method”:“GET”,“url”:"/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194?access_token=Y99CZz5svezI69zCVV3VlFNhI1zuuSHg&access_token_ttl=0&permission=edit",“message”:“Loaded WOPI Token record: {“id”:“1005”,“owner_uid”:“stefan”,“editor_uid”:“stefan”,“fileid”:“94256121”,“version”:“0”,“canwrite”:“1”,“server_host”:“https://ce-stan.feste-ip.net/",“token”:“Y99CZz5svezI69zCVV3VlFNhI1zuuSHg”,“expiry”:“1552815980”,“guest_displayname”:null,“template_destination”:“0”}.",“userAgent”:"LOOLWSD WOPI Agent 4.0.2”,“version”:“15.0.5.3”}
{“reqId”:“Yq6QsSk7nSVdMGimcxwy”,“level”:0,“time”:“2019-03-17T09:16:21+00:00”,“remoteAddr”:“2a02:908:8a9:4260:921b:eff:fe9f:a15f”,“user”:”–",“app”:“no app in context”,“method”:“GET”,“url”:"/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194?access_token=Y99CZz5svezI69zCVV3VlFNhI1zuuSHg&access_token_ttl=0&permission=edit",“message”:“No cache entry found for /appdata_ocddt7r4b194/avatar/stefan/avatar.jpg (storage: local::/media/sde1/home/nextcloud_data/, internalPath: appdata_ocddt7r4b194/avatar/stefan/avatar.jpg)”,“userAgent”:“LOOLWSD WOPI Agent 4.0.2”,“version”:“15.0.5.3”}
{“reqId”:“0X0c6mqLuKCO4jDqt1Ih”,“level”:0,“time”:“2019-03-17T09:16:21+00:00”,“remoteAddr”:“2a02:908:8a9:4260:921b:eff:fe9f:a15f”,“user”:"–",“app”:“richdocuments”,“method”:“GET”,“url”:"/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194/contents?access_token=Y99CZz5svezI69zCVV3VlFNhI1zuuSHg&access_token_ttl=0&permission=edit",“message”:“Loaded WOPI Token record: {“id”:“1005”,“owner_uid”:“stefan”,“editor_uid”:“stefan”,“fileid”:“94256121”,“version”:“0”,“canwrite”:“1”,“server_host”:“https://ce-stan.feste-ip.net/",“token”:“Y99CZz5svezI69zCVV3VlFNhI1zuuSHg”,“expiry”:“1552815980”,“guest_displayname”:null,“template_destination”:“0”}.",“userAgent”:"LOOLWSD WOPI Agent 4.0.2”,“version”:“15.0.5.3”}
{“reqId”:“ehhU8X1uCTThFBDnHbPQ”,“level”:0,“time”:“2019-03-17T09:16:27+00:00”,“remoteAddr”:“2a02:908:8a9:4260:921b:eff:fe9f:a15f”,“user”:”–",“app”:“richdocuments”,“method”:“GET”,“url”:"/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194?access_token=Y99CZz5svezI69zCVV3VlFNhI1zuuSHg&access_token_ttl=0&permission=edit",“message”:“Loaded WOPI Token record: {“id”:“1005”,“owner_uid”:“stefan”,“editor_uid”:“stefan”,“fileid”:“94256121”,“version”:“0”,“canwrite”:“1”,“server_host”:“https://ce-stan.feste-ip.net/",“token”:“Y99CZz5svezI69zCVV3VlFNhI1zuuSHg”,“expiry”:“1552815980”,“guest_displayname”:null,“template_destination”:“0”}.",“userAgent”:"LOOLWSD WOPI Agent 4.0.2”,“version”:“15.0.5.3”}
{“reqId”:“ehhU8X1uCTThFBDnHbPQ”,“level”:0,“time”:“2019-03-17T09:16:27+00:00”,“remoteAddr”:“2a02:908:8a9:4260:921b:eff:fe9f:a15f”,“user”:”–",“app”:“no app in context”,“method”:“GET”,“url”:"/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194?access_token=Y99CZz5svezI69zCVV3VlFNhI1zuuSHg&access_token_ttl=0&permission=edit",“message”:“No cache entry found for /appdata_ocddt7r4b194/avatar/stefan/avatar.jpg (storage: local::/media/sde1/home/nextcloud_data/, internalPath: appdata_ocddt7r4b194/avatar/stefan/avatar.jpg)”,“userAgent”:“LOOLWSD WOPI Agent 4.0.2”,“version”:“15.0.5.3”}
{“reqId”:“othkjPQ7SmRMCiiPBeLO”,“level”:0,“time”:“2019-03-17T09:16:27+00:00”,“remoteAddr”:“2a02:908:8a9:4260:921b:eff:fe9f:a15f”,“user”:"–",“app”:“richdocuments”,“method”:“GET”,“url”:"/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194/contents?access_token=Y99CZz5svezI69zCVV3VlFNhI1zuuSHg&access_token_ttl=0&permission=edit",“message”:"Loaded WOPI Token record: {“id”:“1005”,“owner_uid”:“stefan”,“editor_uid”:“stefan”,“fileid”:“94256121”,“version”:“0”,“canwrite”:“1”,“server_host”:“https://ce-stan.feste-ip.net/",“token”:“Y99CZz5svezI69zCVV3VlFNhI1zuuSHg”,“expiry”:“1552815980”,“guest_displayname”:null,“template_destination”:“0”}.",“userAgent”:"LOOLWSD WOPI Agent 4.0.2”,“version”:“15.0.5.3”}

Thanks, Stefan.

Mhh, I gues I’m getting a bit closer to the issue.

The loolwsd log entries from the syslog shows the following:

Mar 17 12:09:47 ce loolwsd[7129]: wsd-07129-07144 2019-03-17 11:09:47.829770 [ websrv_poll ] ERR Requesting address is denied: ::ffff:127.0.0.1| wsd/LOOLWSD.cpp:1978
Mar 17 12:09:47 ce loolwsd[7129]: wsd-07129-07144 2019-03-17 11:09:47.852239 [ websrv_poll ] ERR Requesting address is denied: ::ffff:127.0.0.1| wsd/LOOLWSD.cpp:1978
Mar 17 12:09:50 ce loolwsd[7129]: kit-08162-08163 2019-03-17 11:09:50.963654 [ lo_startmain ] SIG Fatal signal received: SIGABRT
Mar 17 12:09:50 ce loolwsd[7129]: Backtrace 8162:
_Mar 17 12:09:50 ce loolwsd[7129]: /usr/bin/loolforkit(ZN7SigUtil13dumpBacktraceEv+0x5f) [0x4b3d1f]
Mar 17 12:09:50 ce loolwsd[7129]: /usr/bin/loolforkit() [0x4b4e60]
Mar 17 12:09:50 ce loolwsd[7129]: /lib/x86_64-linux-gnu/libpthread.so.0(+0x11390) [0x7ff063016390]
Mar 17 12:09:50 ce loolwsd[7129]: /lib/x86_64-linux-gnu/libc.so.6(gsignal+0x38) [0x7ff062c70428]
Mar 17 12:09:50 ce loolwsd[7129]: /lib/x86_64-linux-gnu/libc.so.6(abort+0x16a) [0x7ff062c7202a]
_Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(ZN16SalUserEventList18DispatchUserEventsEb+0x39c) [0x7ff0600cf33c]
_Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(ZN14SvpSalInstance7DoYieldEbb+0x39) [0x7ff06017b239]
_Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(ZN11Application5YieldEv+0x2e) [0x7ff0600e051e]
_Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(ZN11Application7ExecuteEv+0x45) [0x7ff0600e1e15]
Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(+0x1f0f70c) [0x7ff05f0b070c]
Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(+0x2f467c6) [0x7ff0600e77c6]
_Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(Z6SVMainv+0x22) [0x7ff0600e78b2]
Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(soffice_main+0x8a) [0x7ff05f0d00ea]
Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libmergedlo.so(+0x1f3edd1) [0x7ff05f0dfdd1]
Mar 17 12:09:50 ce loolwsd[7129]: /opt/collaboraoffice6.0/program/libuno_sal.so.3(+0x40ea7) [0x7ff058ef2ea7]
Mar 17 12:09:50 ce loolwsd[7129]: /lib/x86_64-linux-gnu/libpthread.so.0(+0x76ba) [0x7ff06300c6ba]
Mar 17 12:09:50 ce loolwsd[7129]: /lib/x86_64-linux-gnu/libc.so.6(clone+0x6d) [0x7ff062d4241d]
Mar 17 12:09:52 ce loolwsd[7129]: wsd-07129-08267 2019-03-17 11:09:52.131458 [ docbroker_008 ] ERR Invalid or unknown session [0026] to remove.| wsd/DocumentBroker.cpp:1159
Mar 17 12:09:52 ce loolwsd[7129]: wsd-07129-08267 2019-03-17 11:09:52.131517 [ docbroker_008 ] ERR No socket associated with WebSocketHandler 0x7f06a0018d90| ./net/WebSocketHandler.hpp:108

There is an error message stating that access from localP address is denied.
But I have no idea how to solve this.

Any help is higly appreciated.

Thanks, Stefan.

@Brakelmann

Ok what you posted seems good

(FYI in terms of errors I usually look for 3 sources - nextcloud log, http-error.log (if apache), a syslog for the loolwsd service unless you modified loolwsd.xml to use a different location)

OK so the error you posted probably has to do with WOPI storage within the loolwsd.xml file. Are you running Collabora natively or in docker? Have you tried modifying the loolswsd.xml in either?

I am runnig Collabora installed on ubuntu 16.04. using the packet manager and the ubuntu packages from:
https://www.collaboraoffice.com/repos/CollaboraOnline/CODE
I am running Collabora behind an apache reverse proxy.

I completely removed the lool and openoffice packages and started a fresh install.
So I found out that the loolwsd.xml was updadet and adjusted some parameters.
With that I was able to solve the error with the IP address:
Mar 17 12:09:47 ce loolwsd[7129]: wsd-07129-07144 2019-03-17 11:09:47.829770 [ websrv_poll ] ERR Requesting address is denied: ::ffff:127.0.0.1| wsd/LOOLWSD.cpp:1978

But it is still not working.
Digging intol lool log files in debug mode I found out that there is still an issue with the docbrooker:

wsd-04293-05092 2019-03-18 07:34:23.329261 [ docbroker_00b ] DBG #28 Thread affinity set to 0 (was 0x7ff753fff700).| ./net/Socket.hpp:279
wsd-04293-05092 2019-03-18 07:34:23.329266 [ docbroker_00b ] DBG SslStreamSocket dtor #28| ./net/SslSocket.hpp:61
wsd-04293-05092 2019-03-18 07:34:23.329268 [ docbroker_00b ] DBG SslStreamSocket::closeConnection() #28| ./net/SslSocket.hpp:75
wsd-04293-05092 2019-03-18 07:34:23.329370 [ docbroker_00b ] DBG StreamSocket dtor #28| ./net/Socket.hpp:796
wsd-04293-05092 2019-03-18 07:34:23.329378 [ docbroker_00b ] INF ToClient-0012 Disconnected, current number of connections: 3| wsd/ClientSession.cpp:1158
wsd-04293-05092 2019-03-18 07:34:23.329381 [ docbroker_00b ] DBG ToClient-0012 on docKey [/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194] terminated. Cleaning up.| wsd/ClientSession.cpp:1168
wsd-04293-05092 2019-03-18 07:34:23.329385 [ docbroker_00b ] ERR Invalid or unknown session [0012] to remove.| wsd/DocumentBroker.cpp:1159
wsd-04293-05092 2019-03-18 07:34:23.329389 [ docbroker_00b ] ERR No socket associated with WebSocketHandler 0x7ff76001b4f0| ./net/WebSocketHandler.hpp:108
wsd-04293-05092 2019-03-18 07:34:23.329393 [ docbroker_00b ] INF ~ClientSession dtor [ToClient-0012], current number of connections: 2| wsd/ClientSession.cpp:64
wsd-04293-05092 2019-03-18 07:34:23.329422 [ docbroker_00b ] INF Finished docBroker polling thread for docKey [/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194].| wsd/DocumentBroker.cpp:398
wsd-04293-04297 2019-03-18 07:34:23.329485 [ prisoner_poll ] INF Removing DocumentBroker for docKey [/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194].| wsd/LOOLWSD.cpp:332
wsd-04293-04297 2019-03-18 07:34:23.329494 [ prisoner_poll ] INF Removing complete doc [/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194] from Admin.| wsd/Admin.cpp:485
wsd-04293-04297 2019-03-18 07:34:23.329502 [ prisoner_poll ] INF ~DocumentBroker [/index.php/apps/richdocuments/wopi/files/94256121_ocddt7r4b194] destroyed with 0 sessions left.| wsd/DocumentBroker.cpp:419

But I have no clue how to get into this.

Best regards, Stefan.

Hi!

i have the same problem after NC update from 14 to 15.05.
My collabora is running as docker at another VPS/Ubuntu
The docker log is showing errors:

d-00025-23650 16:38:18.655567 [ client_req_hdl ] WRN WOPI host did not pass optional access_token_ttl| wsd/FileServer.cpp:255

wsd-00025-23651 16:38:19.499149 [ client_ws_0861 ] WRN Missing JSON property [HidePrintOption]| wsd/Storage.cpp:353

wsd-00025-23651 16:38:19.499342 [ client_ws_0861 ] WRN Missing JSON property [HideSaveOption]| wsd/Storage.cpp:353

wsd-00025-23651 16:38:19.499470 [ client_ws_0861 ] WRN Missing JSON property [HideExportOption]| wsd/Storage.cpp:353

wsd-00025-23651 16:38:19.499595 [ client_ws_0861 ] WRN Missing JSON property [EnableOwnerTermination]| wsd/Storage.cpp:353

wsd-00025-23651 16:38:19.499729 [ client_ws_0861 ] WRN Missing JSON property [DisablePrint]| wsd/Storage.cpp:353

wsd-00025-23651 16:38:19.499840 [ client_ws_0861 ] WRN Missing JSON property [DisableExport]| wsd/Storage.cpp:353

wsd-00025-23651 16:38:19.499944 [ client_ws_0861 ] WRN Missing JSON property [DisableCopy]| wsd/Storage.cpp:353

wsd-00025-9678 16:38:21.120339 [ client_ws_0862 ] ERR ClientRequestHandler::handleClientRequest: BadRequestException: Failed to convert and send file.| wsd/LOOLWSD.cpp:1240

wsd-00025-22748 16:38:21.144099 [ client_ws_0863 ] ERR ClientRequestHandler::handleClientRequest: BadRequestException: Failed to convert and send file.| wsd/LOOLWSD.cpp:1240

wsd-00025-23665 16:38:21.249681 [ client_ws_0864 ] ERR ClientRequestHandler::handleClientRequest: BadRequestException: Failed to convert and send file.| wsd/LOOLWSD.cpp:1240

wsd-00025-23666 16:38:26.752022 [ docbrk_ws_23655 ] ERR Failed to save to URI [https://**************/index.php/apps/richdocuments/wopi/files/343205_oc9nrv2vcl9o?access_token=wWCsHtrymTMKX4yESJ4yDFtIhsakUIo0&access_token_ttl=0&permission=edit].| wsd/DocumentBroker.cpp:409

wsd-00025-23666 16:38:26.752149 [ docbrk_ws_23655 ] ERR Saving document to storage failed.| wsd/PrisonerSession.cpp:91

maybe this helps to find the problem!

a docker update solved my problem!

Hi Richard,

so I might give docker a try.
Maybe the deb build from the packetmanger is broken.

I didn’t use docker from the beginning as the docker image didn’t support IPV 6 environments.
Does it support IPV6 as of today?

Thanks, Stefan.

@Brakelmann

To the best of my knowledge, I don’t think the docker image and the direct install method are any different in terms of functionality. Richards error was different than yours. I’ve used both the docker image and the deb method directly installed on Ubuntu. I didn’t see much different between the two. You posted something about a socket error I believe. Did you change something in the loolwsd.xml?

I did a fresh install and recognized that the loolwsd.xml was quite different than the one I used before.
I added my host in the Network Settings section, which solved my first error:
Mar 17 12:09:47 ce loolwsd[7129]: wsd-07129-07144 2019-03-17 11:09:47.829770 [ websrv_poll ] ERR Requesting address is denied: ::ffff:127.0.0.1| wsd/LOOLWSD.cpp:1978

I changed SLL encryption (with Self Signed Cert inside loolwsd) to no SSL encryption and changed my apache reverse proxy to http. This solved a SSL Error message wich I am not sure if it was an error or just a warning without any functional impact.
I am using the apache config like in the samples of the collabora web page:

It is pretty strange since the documents do load without any problems, but as soon as I type a letter I get the an error message and the docbroker is closing the session.

I also set up a vm with ubuntu and installed collabora to exclude my system, without success.
I do get the same problem in the vm ware than in my live system.
At the moment I am installing Collabora with this script:

It will run over night and I will figure out if this will lead to a working system.

If not I will get back to loolwsd debugging. I already did some tracing and debugging.
As soon a the client cocket sends data (on pressing a key inside a document) the socket is closed and the document will load again.

I will update tomorrow.

Thanks all for your support here, Stefan.

Why are using that script to build loolwsd server? Have you taken a look at this page??: https://www.collaboraoffice.com/code/linux-packages/

Just add the apt repository and then install the package – no need to compile.
In terms of certificates – yea that could always be an issue and I’m not the best at debugging these errors honestly. I just use Let’s Encrypt certs and I’m done with that mess. I guess turning SSL off and using http is a work-a-round, however I never had to do that so I can’t help you with that problem.

In terms of docbrocker, yikes, the error your describing is very strange. Did you report at github?https://github.com/CollaboraOnline
I’m not going to be much help in terms of the docbroder since it is something I haven’t run into before or even read about. Try installing from apt package to narrow down potential issues.

Blockquote
Why are using that script to build loolwsd server? Have you taken a look at this page??: Setting up and configuring native CODE packages on Linux - Collabora Office and Collabora Online

I want to figure if maybe the build within the apt repository is broken, or if there is any difference.

I am running letsencrypt either in my apache, maybe I should use these certificates for loolwsd too, but there was no need before the update. I will give it a try.

If the problem with docbroker will persist in the installatio with the script I will follow up opening a ticket on github.

BR, Stefan.

Hello,

I have the same problem, and i search also a solution, without success.
In my log (journalctl -u loolwsd) i have this:
[ lo_startmain ] SIG Fatal signal received: SIGABRT
Visibly it’s a compil error version

I see in this issue :
Last known good configuration:
##########################
set_core_regex=‘cp-5.3$’
set_online_regex=‘collabora/collabora-online-3$’
lo_src_branch=‘distro/collabora/cp-5.3’
lo_src_tag=‘cp-5.3-61’
lool_src_tag=‘3.4.2-1’
###########################

Ok but how change to collabora 6.0.10.26-26 ?
change to code-brand_4.0-2 ?
libpoco-dev_1.9.0-1 ?
The last version in https://www.collaboraoffice.com/repos/CollaboraOnline/CODE/

Hello.
thanks for the link https://github.com/husisusi/officeonlin-install.sh/issues/155#issuecomment-457002079
apt install hunspell locales-all hunspell-ru
helps me.

1 Like

Thanks maz i have try this command
apt install hunspell locales-all hunspell-fr
and restart loolwsd service
And now no more problem
It’s strange because I thought I had tested this command before without success… But the principal, but the main thing is that it’s okay now !

Hi maz,

your link was the solution for my issue.
I did debug and research the whole weekend and at the end it was a missing component.

Thanks all, Stefan.