Hi,
We implemented onlyoffice-documentserver-de v8.1 on a Debian 11 and we are facing an error when saving a file.
This worked perfectly with onlyoffice-documentserver-de v7.5 and the error started happening as soon as we upgraded onlyoffice to the v8.
In our config file, “assemblyFormatAsOrigin” is at false.
We can open a .docx file and edit it we wish, but when a forcesave command is issued, an error occurs. Here are the logs (a lot of the informations have been hidden by parameters)
doc service:
[2024-03-04T14:49:40.996] [INFO] [localhost] [<office_file_key>] [<user_id>] nodeJS - data.type = forceSaveStart
[2024-03-04T14:49:40.996] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - startForceSave start
[2024-03-04T14:49:40.998] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - startForceSave canStart: hasEncrypted = false; applyCacheRes = {“code”:0,“time”:null,“inProgress”:false}; startedForceSave = {“started”:true,“time”:1709560165000,“changeInfo”:{“user_id”:“<user_id>”,“user_id_original”:“<user_id_orignal>”,“user_name”:“<user_name>”,“change_date”:1709560165000},“baseUrl”:“https://<callback_url>.io”,“ended”:false,“index”:16}
[2024-03-04T14:49:41.003] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - getCallbackByUserIndex: userIndex = undefined callbacks = {“userIndex”:1,“callback”:“https://office.
qa.io:4443/office/save?user_id=<user_id_orignal>&file_master_id=12657364&file_type=10&client_original_ip=<user_ip>&user_token=<user_token>&account_id=1&office_file_key=<office_file_key>&fileExtension=docx”}
[2024-03-04T14:49:41.003] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - getCallbackByUserIndex: userIndex = undefined callbacks = {“userIndex”:1,“callback”:“https://<callback_url>.io:4443/office/save?user_id=<user_id_orignal>&file_master_id=12657364&file_type=10&client_original_ip=<user_ip>&user_token=<user_token>&account_id=1&office_file_key=<office_file_key>&fileExtension=docx”}
[2024-03-04T14:49:41.013] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - Start convert request
[2024-03-04T14:49:41.018] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - End convert request end true status 0
[2024-03-04T14:49:41.020] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - startForceSave convertFromChanges: status = 0
[2024-03-04T14:49:41.020] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - startForceSave end
[2024-03-04T14:49:41.021] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - sendData: type = forceSaveStart
[2024-03-04T14:49:41.073] [INFO] [localhost] [<office_file_key>] [<user_id>] nodeJS - receiveTask start: {“ctx”:{“tenant”:“localhost”,“docId”:“<office_file_key>”,“userId”:“<user_id>”,“shardKey”:“<office_file_key>”},“cmd”:{“externalChangeInfo”:{“user_id”:“<user_id>”,“user_id_original”:“<user_id_orignal>”,“user_name”:“<user_name>”,“change_date”:1709560165000},“wopiParams”:null,“c”:“sfcm”,“id”:“<office_file_key>”,“userid”:“<user_id_orignal>”,“userindex”:1,“data”:null,“title”:“output.ooxml”,“outputformat”:2055,“outputpath”:“output.ooxml”,“codepage”:46,“delimiter”:4,“embeddedfonts”:false,“status_info”:-88,“savekey”:“<office_file_key>_4982”,“userconnectionid”:“<user_id>”,“jsonparams”:“{"documentLayout":{"openedAt":1709563751402}}”,“forcesave”:{“type”:1,“time”:1709560165000,“index”:16,“authoruserid”:“<user_id_orignal>”,“authoruserindex”:1},“nobase64”:true,“originformat”:65}}
[2024-03-04T14:49:41.080] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - Start commandSfcCallback
[2024-03-04T14:49:41.081] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - getCallbackByUserIndex: userIndex = 1 callbacks = {“userIndex”:1,“callback”:“https://<callback_url>.io:4443/office/save?user_id=<user_id_orignal>&file_master_id=12657364&file_type=10&client_original_ip=<user_ip>&user_token=<user_token>&account_id=1&office_file_key=<office_file_key>&fileExtension=docx”}
[2024-03-04T14:49:41.081] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - Callback commandSfcCallback: callback = https://<callback_url>.io:4443/office/save?user_id=<user_id_orignal>&file_master_id=12657364&file_type=10&client_original_ip=<user_ip>&user_token=<user_token>&account_id=1&office_file_key=<office_file_key>&fileExtension=docx
[2024-03-04T14:49:41.082] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - postData request: url = https://<callback_url>.io:4443/office/save?user_id=<user_id_orignal>&file_master_id=12657364&file_type=10&client_original_ip=<user_ip>&user_token=<user_token>&account_id=1&office_file_key=<office_file_key>&fileExtension=docx;data = {“key”:“<office_file_key>”,“status”:7,“users”:[“<user_id_orignal>”],“actions”:[{“type”:2,“userid”:“<user_id_orignal>”}],“lastsave”:“2024-03-04T13:49:25.000Z”,“forcesavetype”:1}
[2024-03-04T14:49:41.135] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - postData response: data = {“error”: 1}
[2024-03-04T14:49:41.136] [WARN] [localhost] [<office_file_key>] [<user_id>] nodeJS - sendServerRequest returned an error: data = {“error”: 1}
[2024-03-04T14:49:41.137] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - End commandSfcCallback
[2024-03-04T14:49:41.137] [INFO] [localhost] [<office_file_key>] [<user_id>] nodeJS - receiveTask end
[2024-03-04T14:49:41.138] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - pubsub message start:{“type”:12,“ctx”:{“tenant”:“localhost”,“docId”:“<office_file_key>”,“userId”:“<user_id>”,“shardKey”:“<office_file_key>”},“docId”:“<office_file_key>”,“data”:{“type”:1,“time”:1709560165000,“success”:false}}
[2024-03-04T14:49:41.138] [DEBUG] [localhost] [<office_file_key>] [<user_id>] nodeJS - sendData: type = forceSave
CONVERTER LOG
[2024-03-04T14:51:04.490] [INFO] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - Start Task
[2024-03-04T14:51:04.494] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - downloadFileFromStorage list 7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/Editor.bin,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image1.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image10.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image11.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image12.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image13.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image14.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image15.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image16.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image17.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image18.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image19.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image2.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image20.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image21.jpg,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image3.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image4.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image5.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image6.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image7.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image8.png,7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513/media/image9.png
[2024-03-04T14:51:04.506] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - downloadFileFromStorage complete
[2024-03-04T14:51:04.507] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - downloadFileFromStorage list
[2024-03-04T14:51:04.519] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - processChanges end
[2024-03-04T14:51:04.549] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - error spawnAsync Error: Process exited with non-zero code: 88
at ChildProcess. (/snapshot/server/FileConverter/node_modules/@expo/spawn-async/build/spawnAsync.js:39:21)
at ChildProcess.emit (node:events:527:28)
at maybeClose (node:internal/child_process:1092:16)
at Socket. (node:internal/child_process:451:11)
at Socket.emit (node:events:527:28)
at Pipe. (node:net:709:12)
[2024-03-04T14:51:04.549] [ERROR] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - stdout:
[2024-03-04T14:51:04.549] [ERROR] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - stderr:
[2024-03-04T14:51:04.549] [ERROR] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - ExitCode (code=88;signal=null;error:-88)
[2024-03-04T14:51:04.550] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - output (data={“ctx”:{“tenant”:“localhost”,“docId”:“7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513”,“userId”:“<user_id>”,“shardKey”:“7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513”},“cmd”:{“externalChangeInfo”:{“user_id”:“<user_id>”,“user_id_original”:“<original_user_id>”,“user_name”:“<user_name>”,“change_date”:1709560262000},“wopiParams”:null,“c”:“sfcm”,“id”:“7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513”,“userid”:“<original_user_id>”,“userindex”:1,“data”:null,“title”:“output.ooxml”,“outputformat”:2055,“outputpath”:“output.ooxml”,“codepage”:46,“delimiter”:4,“embeddedfonts”:false,“status_info”:-88,“savekey”:“7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513_5069”,“userconnectionid”:“<user_id>”,“jsonparams”:“{"documentLayout":{"openedAt":1709563751402}}”,“forcesave”:{“type”:1,“time”:1709560262000,“index”:27,“authoruserid”:“<original_user_id>”,“authoruserindex”:1},“nobase64”:true,“originformat”:65}})
[2024-03-04T14:51:04.550] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - postProcess
[2024-03-04T14:51:04.552] [DEBUG] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - deleteFolderRecursive
[2024-03-04T14:51:04.552] [INFO] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - End Task
[2024-03-04T14:51:04.562] [INFO] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - ackTask addResponse
[2024-03-04T14:51:04.562] [INFO] [localhost] [7f066f44c3f78191976fdfb970c36c432b34acf9b1d6f84d492516a54a731513] [<user_id>] nodeJS - ackTask ack
It seems like there is an error during the conversion process that triggers an error code 88.
All those logs are during a forcesave on an edited .docx file.
It’s also important to specify that when we set assemblyFormatAsOrigin to true, the docx save is working, but the .doc save does not work anymore.
Thanks in advance and sorry for the medium english.