CollaboraOnline / online

Collabora Online is a collaborative online office suite based on LibreOffice technology. This is also the source for the Collabora Office apps for iOS and Android.
https://collaboraonline.com
Other
1.78k stars 681 forks source link

Cannot open dockument #3911

Closed kukachik closed 2 years ago

kukachik commented 2 years ago

Collabora is trying, but without luck.

Oracle arm64 VPS.

Logs
only bug, i think it is. loading document -

wsd-00001-00547 2021-12-31 06:39:41.851705 +0000 [ docbroker_004 ] DBG StreamSocket dtor #32 with pending write: 0, read: 0| ./net/Socket.hpp:937 wsd-00001-00547 2021-12-31 06:39:41.852443 +0000 [ docbroker_004 ] INF WOPI::GetFile downloaded 266559 bytes from [https://domain.duckdns.org/index.php/apps/richdocuments/wopi/files/622_oc1ax2fda0jy/contents?access_token=&access_token_ttl=0] -> /opt/cool/child-roots/g7MPYqZvCMbYMWzJ/tmp/user/docs/g7MPYqZvCMbYMWzJ/stulchik.docx in 165ms| wsd/Storage.cpp:1115 wsd-00001-00547 2021-12-31 06:39:41.854769 +0000 [ docbroker_004 ] INF SHA1 for DocKey [/index.php/apps/richdocuments/wopi/files/622_oc1ax2fda0jy] of [/tmp/user/docs/g7MPYqZvCMbYMWzJ/stulchik.docx]: dc5ed3a5db753f1477b6181bcc6f6cbf774a9049| wsd/DocumentBroker.cpp:945 wsd-00001-00547 2021-12-31 06:39:41.855300 +0000 [ docbroker_004 ] INF TileCache ctor for uri [https://domain.duckdns.org/index.php/apps/richdocuments/wopi/files/622_oc1ax2fda0jy?access_token=&access_token_ttl=0], modifiedTime=1640932781], dontCache=false| wsd/TileCache.cpp:43 wsd-00001-00026 2021-12-31 06:39:41.855857 +0000 [ admin ] DBG Added admin document [/index.php/apps/richdocuments/wopi/files/622_oc1ax2fda0jy].| wsd/AdminModel.cpp:516 wsd-00001-00547 2021-12-31 06:39:41.856373 +0000 [ docbroker_004 ] INF Filesystem [/opt/cool/child-roots/.] has 135775 MB free (91.3231%).| common/FileUtil.cpp:514 wsd-00001-00547 2021-12-31 06:39:41.856876 +0000 [ docbroker_004 ] DBG #24 thread affinity set to 0xffffa37fe0c0 (was 0)| net/Socket.hpp:314 wsd-00001-00547 2021-12-31 06:39:41.857348 +0000 [ docbroker_004 ] DBG Starting handling poll results of docbroker_004 at index 0 (of 2)| net/Socket.cpp:453 wsd-00001-00547 2021-12-31 06:39:41.857812 +0000 [ docbroker_004 ] DBG Starting handling poll results of docbroker_004 at index 1 (of 2)| net/Socket.cpp:453 wsd-00001-00547 2021-12-31 06:39:41.858275 +0000 [ docbroker_004 ] INF Client timestamps: Date.now():1640932780562, performance.now():1106 => 1640932779456000| wsd/ClientSession.cpp:513 wsd-00001-00547 2021-12-31 06:39:41.858898 +0000 [ docbroker_004 ] INF Requesting document load from child.| wsd/ClientSession.cpp:1037 wsd-00001-00547 2021-12-31 06:39:41.859462 +0000 [ docbroker_004 ] DBG Starting handling poll results of docbroker_004 at index 0 (of 2)| net/Socket.cpp:453 frk-00021-00021 2021-12-31 06:39:42.168016 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00021-00021 2021-12-31 06:39:43.168311 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00021-00021 2021-12-31 06:39:44.169409 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00021-00021 2021-12-31 06:39:45.170501 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 wsd-00001-00024 2021-12-31 06:39:46.160305 +0000 [ accept_poll ] DBG Starting handling poll results of accept_poll at index 0 (of 1)| net/Socket.cpp:453 frk-00021-00021 2021-12-31 06:39:46.172361 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 wsd-00001-00020 2021-12-31 06:39:46.352317 +0000 [ prisoner_poll ] DBG Starting handling poll results of prisoner_poll at index 0 (of 2)| net/Socket.cpp:453 kit-00548-00021 2021-12-31 06:39:46.524337 +0000 [ kit_spare_04b ] SIG kit-00549-00021 2021-12-31 06:39:46.524391 +0000 [ kit_spare_04c ] SIG Fatal signal received: SIGABRT Backtrace 549 - kit startup of 21.11.0.6 1e92cc5cf: /usr/bin/coolforkit(_ZN7SigUtil13dumpBacktraceEv+0x80)[0xaaaab4f0ac08] /usr/bin/coolforkit(+0x1eb8f8)[0xaaaab4f0b8f8] linux-vdso.so.1(__kernel_rt_sigreturn+0x0)[0xffffaca3d794] /lib/aarch64-linux-gnu/libc.so.6(raise+0xb0)[0xffffac3a84f8] Fatal signal received: SIGABRT Backtrace 548 - kit startup of 21.11.0.6 1e92cc5cf: /usr/bin/coolforkit(_ZN7SigUtil13dumpBacktraceEv+0x80)[0xaaaab4f0ac08] /usr/bin/coolforkit(+0x1eb8f8)[0xaaaab4f0b8f8] linux-vdso.so.1(__kernel_rt_sigreturn+0x0)[0xffffaca3d794] /lib/aarch64-linux-gnu/libc.so.6(raise+0xb0)[0xffffac3a84f8] wsd-00001-00547 2021-12-31 06:39:46.734267 +0000 [ docbroker_004 ] DBG Starting handling poll results of docbroker_004 at index 1 (of 2)| net/Socket.cpp:453 wsd-00001-00547 2021-12-31 06:39:46.734345 +0000 [ docbroker_004 ] DBG Starting handling poll results of docbroker_004 at index 0 (of 2)| net/Socket.cpp:453 wsd-00001-00547 2021-12-31 06:39:46.734356 +0000 [ docbroker_004 ] ERR #20: Socket read returned -1 (ECONNRESET: Connection reset by peer)| ./net/Socket.hpp:1121 wsd-00001-00547 2021-12-31 06:39:46.734385 +0000 [ docbroker_004 ] DBG Stopping DocumentBroker for docKey [/index.php/apps/richdocuments/wopi/files/622_oc1ax2fda0jy] with reason: docdisconnected| wsd/DocumentBroker.cpp:545 wsd-00001-00547 2021-12-31 06:39:46.734397 +0000 [ docbroker_004 ] DBG Removing socket #20 (at 0 of 2) from docbroker_004| net/Socket.cpp:490 wsd-00001-00547 2021-12-31 06:39:46.734404 +0000 [ docbroker_004 ] INF Finished polling doc [/index.php/apps/richdocuments/wopi/files/622_oc1ax2fda0jy]. stop: true, continuePolling: true, ShutdownRequestFlag: false, TerminationFlag: false, closeReason: docdisconnected. Flushing socket.| wsd/DocumentBroker.cpp:453 wsd-00001-00547 2021-12-31 06:39:46.734412 +0000 [ docbroker_004 ] INF Flushing socket for doc [/index.php/apps/richdocuments/wopi/files/622_oc1ax2fda0jy] for 2000000us. stop: true, continuePolling: true, ShutdownRequestFlag: false, TerminationFlag: false. Terminating child with reason: [docdisconnected].| wsd/DocumentBroker.cpp:469

restart container

wsd-00001-00001 2021-12-31 08:02:00.061510 +0000 [ coolwsd ] DBG New SocketPoll [main] owned by 0xffffa136b010| net/Socket.cpp:213 Ready to accept connections on port 9980.

wsd-00001-00027 2021-12-31 08:02:00.061518 +0000 [ admin ] INF Thread 27 (ffff9affd0c0) of process 1 formerly unnamed is now called [admin]| common/Util.cpp:549 kit-00024-00022 2021-12-31 08:02:00.061526 +0000 [ kit_spare_001 ] TRC #0 wrote 458 bytes of 458| net/Socket.hpp:1084 wsd-00001-00027 2021-12-31 08:02:00.061574 +0000 [ admin ] INF Starting polling thread [admin] with thread affinity set to 0xffff9affd0c0.| net/Socket.cpp:316 kit-00024-00022 2021-12-31 08:02:00.061580 +0000 [ kit_spare_001 ] TRC #15 Connected to WS Handler 0xaaaaf0b987d0| ./net/WebSocketHandler.hpp:166 kit-00024-00022 2021-12-31 08:02:00.061588 +0000 [ kit_spare_001 ] DBG Inserting socket #15 into kit| ./net/Socket.hpp:734 kit-00024-00022 2021-12-31 08:02:00.061593 +0000 [ kit_spare_001 ] DBG #15 resetting thread affinity while in transit (was 0xffff840e4010)| ./net/Socket.hpp:325 kit-00024-00022 2021-12-31 08:02:00.061610 +0000 [ kit_spare_001 ] TRC #15: Set socket buffer size to 262144| ./net/Socket.hpp:235 kit-00024-00022 2021-12-31 08:02:00.061616 +0000 [ kit_spare_001 ] INF New kit client websocket inserted.| kit/Kit.cpp:2810 kit-00024-00022 2021-12-31 08:02:00.061620 +0000 [ kit_spare_001 ] INF Kit initialization complete: setting log-level to [debug] as configured.| kit/Kit.cpp:2815 kit-00024-00022 2021-12-31 08:02:00.061626 +0000 [ kit_spare_001 ] INF Kit unipoll loop run| kit/Kit.cpp:2828 office version details: { "ProductName": "Collabora Office", "ProductVersion": "21.06", "ProductExtension": ".10.1", "BuildId": "d382e7c1decd39c4f3d8a25ce4e808e79b516e68" } frk-00022-00022 2021-12-31 08:02:00.284347 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00022-00022 2021-12-31 08:02:01.285525 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00022-00022 2021-12-31 08:02:02.287287 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00022-00022 2021-12-31 08:02:03.288409 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00022-00022 2021-12-31 08:02:04.289941 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 kit-00024-00022 2021-12-31 08:02:05.058036 +0000 [ kit_spare_001 ] SIG Fatal signal received: SIGABRT Backtrace 24 - { "ProductName": "Collabora Office", "ProductVersion": "21.06", "ProductExtension": ".10.1", "BuildId": "d382e7c1decd39c4f3d8a25ce4e808e79b516e68" }: /usr/bin/coolforkit(_ZN7SigUtil13dumpBacktraceEv+0x80)[0xaaaae6e3ac08] /usr/bin/coolforkit(+0x1eb8f8)[0xaaaae6e3b8f8] linux-vdso.so.1(__kernel_rt_sigreturn+0x0)[0xffff840f2794] /lib/aarch64-linux-gnu/libc.so.6(raise+0xb0)[0xffff83a5d4f8] wsd-00001-00021 2021-12-31 08:02:05.064342 +0000 [ prisoner_poll ] DBG Starting handling poll results of prisoner_poll at index 0 (of 2)| net/Socket.cpp:453 wsd-00001-00025 2021-12-31 08:02:05.065089 +0000 [ accept_poll ] DBG Starting handling poll results of accept_poll at index 0 (of 1)| net/Socket.cpp:453 frk-00022-00022 2021-12-31 08:02:05.291074 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00022-00022 2021-12-31 08:02:05.291654 +0000 [ forkit ] INF Child 24 has exited, will remove its jail [/opt/cool/child-roots/GTmvhqTSta0JBrDx].| kit/ForKit.cpp:287 frk-00022-00022 2021-12-31 08:02:05.291666 +0000 [ forkit ] WRN No live Kits exist, and we are not terminating yet.| kit/ForKit.cpp:293 frk-00022-00022 2021-12-31 08:02:05.291676 +0000 [ forkit ] INF Removing jail [/opt/cool/child-roots/GTmvhqTSta0JBrDx].| common/JailUtil.cpp:124 frk-00022-00022 2021-12-31 08:02:05.291734 +0000 [ forkit ] DBG Removing [/opt/cool/child-roots/GTmvhqTSta0JBrDx/tmp] recursively.| common/FileUtil.cpp:252 frk-00022-00022 2021-12-31 08:02:05.298337 +0000 [ forkit ] DBG Unmounting [/opt/cool/child-roots/GTmvhqTSta0JBrDx/tmp]| common/JailUtil.cpp:65 frk-00022-00022 2021-12-31 08:02:05.311252 +0000 [ forkit ] DBG Unmounting [/opt/cool/child-roots/GTmvhqTSta0JBrDx/lo]| common/JailUtil.cpp:65 frk-00022-00022 2021-12-31 08:02:05.322196 +0000 [ forkit ] DBG Unmounting [/opt/cool/child-roots/GTmvhqTSta0JBrDx]| common/JailUtil.cpp:65 frk-00022-00022 2021-12-31 08:02:05.332957 +0000 [ forkit ] DBG Removing [/opt/cool/child-roots/GTmvhqTSta0JBrDx] recursively.| common/FileUtil.cpp:252 frk-00022-00022 2021-12-31 08:02:06.397969 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453 frk-00022-00022 2021-12-31 08:02:07.399119 +0000 [ forkit ] DBG Starting handling poll results of forkit at index 0 (of 1)| net/Socket.cpp:453


As i can see, file downloaded successfully

WOPI::GetFile downloaded 266559 bytes from


so, not a problem with proxy, web or nextcloud.

Added, collabora 21.11 interface loading perfectly. 
Collabora 6.4 work.
ruedigerkupper commented 2 years ago

This looks exactly like #3910. You have upgraded from version 6.4 to 21.06 and now you see the forked child process aborting (look out for the string "Fatal signal received: SIGABRT" in your log above).

ruedigerkupper commented 2 years ago

@kukachik If you agree, please close this issue as a duplicate of #3910 and let's continue there.

kukachik commented 2 years ago

Duplicate.