Failing to open documents after Update to Enterprise 7.2.1
-
Hey there!
After an update to OnlyOffice Enterprise 7.2.1 there is an issue with opening some documents.
After a rollback to the previous version everything's fine again.Here is a part of the Log.
2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.231] [WARN] [localhost] [docId] [userId] nodeJS - Express server starting... 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.260] [WARN] [localhost] [docId] [userId] nodeJS - Failed to subscribe to plugin folder updates. When changing the list of plugins, you must restart the server. https://nodejs.org/docs/latest/api/fs.html#fs_availability 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.264] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.772] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,776 INFO success: converter entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,776 INFO success: converter entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,777 INFO success: docservice entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,777 INFO success: docservice entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,778 INFO success: metrics entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,778 INFO success: metrics entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,779 INFO success: nginx entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z 2022-11-22 12:25:07,779 INFO success: nginx entered RUNNING state, process has stayed up for > than 1 seconds (startsecs) 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.776] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.784] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.813] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.831] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.849] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:07.000Z [2022-11-22T12:25:07.914] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:07.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.089] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.267] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.775] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.780] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.788] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.816] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.835] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.852] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:08.000Z [2022-11-22T12:25:08.918] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:08.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:09.000Z [2022-11-22T12:25:09.092] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:09.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:09.000Z [2022-11-22T12:25:09.269] [ERROR] [localhost] [docId] [userId] nodeJS - [AMQP] Error: connect ECONNREFUSED 127.0.0.1:5672 2022-11-22T12:25:09.000Z at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) 2022-11-22T12:25:09.000Z 2022-11-22T12:25:09.000Z ## ## RabbitMQ 3.8.2 2022-11-22T12:25:09.000Z ## ## 2022-11-22T12:25:09.000Z ########## Copyright (c) 2007-2019 Pivotal Software, Inc. 2022-11-22T12:25:09.000Z ###### ## 2022-11-22T12:25:09.000Z ########## Licensed under the MPL 1.1. Website: https://rabbitmq.com 2022-11-22T12:25:09.000Z 2022-11-22T12:25:09.000Z Doc guides: https://rabbitmq.com/documentation.html 2022-11-22T12:25:09.000Z Support: https://rabbitmq.com/contact.html 2022-11-22T12:25:09.000Z Tutorials: https://rabbitmq.com/getstarted.html 2022-11-22T12:25:09.000Z Monitoring: https://rabbitmq.com/monitoring.html 2022-11-22T12:25:09.000Z 2022-11-22T12:25:09.000Z Logs: /var/log/rabbitmq/rabbit@b86b6a4a-0ad7-443d-8716-6affecd8fdee.log 2022-11-22T12:25:09.000Z /var/log/rabbitmq/rabbit@b86b6a4a-0ad7-443d-8716-6affecd8fdee_upgrade.log 2022-11-22T12:25:09.000Z 2022-11-22T12:25:09.000Z Config file(s): (none) 2022-11-22T12:25:09.000Z 2022-11-22T12:25:09.000Z Starting broker... completed with 0 plugins. => Healtheck error got response status 5022022-11-22T12:25:10.000Z [2022-11-22T12:25:10.394] [WARN] [localhost] [docId] [userId] nodeJS - Express server listening on port 8000 in production-linux mode. Version: 7.2.1. Build: 34 2022-11-22T12:25:18.000Z [2022-11-22T12:25:18.568] [ERROR] [localhost] [1302030473] [ocfi59d1h0de_sbosse4] nodeJS - changesError: Error: Uncaught TypeError: Cannot read properties of null (reading 'asc_getSelectionType') Script: https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js Line: 8:2130357 userAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/107.0.0.0 Safari/537.36 platform: Win32 isLoadFullApi: true isDocumentLoadComplete: false StackTrace: TypeError: Cannot read properties of null (reading 'asc_getSelectionType') 2022-11-22T12:25:18.000Z at i.onSelectionChanged (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2130357) 2022-11-22T12:25:18.000Z at i.SetDisabled (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2139606) 2022-11-22T12:25:18.000Z at i.onEditingDisable (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2378275) 2022-11-22T12:25:18.000Z at D (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:7870) 2022-11-22T12:25:18.000Z at e.<anonymous> (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:8074) 2022-11-22T12:25:18.000Z at e.<anonymous> (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:1249) 2022-11-22T12:25:18.000Z at c (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:109801) 2022-11-22T12:25:18.000Z at e.trigger (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:109001) 2022-11-22T12:25:18.000Z at i.disableEditing (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2377421) 2022-11-22T12:25:18.000Z at i.onLongActionEnd (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2364427) 2022-11-22T12:25:19.000Z [2022-11-22T12:25:19.435] [ERROR] [localhost] [2462274415] [ocfi59d1h0de_sbosse3] nodeJS - changesError: Error: Uncaught TypeError: Cannot read properties of null (reading 'asc_getSelectionType') Script: https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js Line: 8:2130357 userAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/107.0.0.0 Safari/537.36 platform: Win32 isLoadFullApi: true isDocumentLoadComplete: false StackTrace: TypeError: Cannot read properties of null (reading 'asc_getSelectionType') 2022-11-22T12:25:19.000Z at i.onSelectionChanged (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2130357) 2022-11-22T12:25:19.000Z at i.SetDisabled (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2139606) 2022-11-22T12:25:19.000Z at i.onEditingDisable (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2378275) 2022-11-22T12:25:19.000Z at D (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:7870) 2022-11-22T12:25:19.000Z at e.<anonymous> (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:8074) 2022-11-22T12:25:19.000Z at e.<anonymous> (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:1249) 2022-11-22T12:25:19.000Z at c (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:109801) 2022-11-22T12:25:19.000Z at e.trigger (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:109001) 2022-11-22T12:25:19.000Z at i.disableEditing (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2377421) 2022-11-22T12:25:19.000Z at i.onLongActionEnd (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2364427) 2022-11-22T12:25:19.000Z [2022-11-22T12:25:19.533] [ERROR] [localhost] [1212199128] [ocfi59d1h0de_sbosse3] nodeJS - changesError: Error: Uncaught TypeError: Cannot read properties of null (reading 'asc_getSelectionType') Script: https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js Line: 8:2130357 userAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/107.0.0.0 Safari/537.36 platform: Win32 isLoadFullApi: true isDocumentLoadComplete: false StackTrace: TypeError: Cannot read properties of null (reading 'asc_getSelectionType') 2022-11-22T12:25:19.000Z at i.onSelectionChanged (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2130357) 2022-11-22T12:25:19.000Z at i.SetDisabled (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2139606) 2022-11-22T12:25:19.000Z at i.onEditingDisable (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2378275) 2022-11-22T12:25:19.000Z at D (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:7870) 2022-11-22T12:25:19.000Z at e.<anonymous> (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:8074) 2022-11-22T12:25:19.000Z at e.<anonymous> (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:1249) 2022-11-22T12:25:19.000Z at c (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:109801) 2022-11-22T12:25:19.000Z at e.trigger (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:109001) 2022-11-22T12:25:19.000Z at i.disableEditing (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2377421) 2022-11-22T12:25:19.000Z at i.onLongActionEnd (https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js:8:2364427) 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,590 INFO reaped unknown pid 549 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,590 INFO reaped unknown pid 549 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,591 INFO reaped unknown pid 550 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,591 INFO reaped unknown pid 550 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,591 INFO reaped unknown pid 584 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,591 INFO reaped unknown pid 584 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,591 INFO reaped unknown pid 554 2022-11-22T12:26:09.000Z 2022-11-22 12:26:09,591 INFO reaped unknown pid 554 2022-11-22T12:27:09.000Z 2022-11-22 12:27:09,661 INFO reaped unknown pid 603 2022-11-22T12:27:09.000Z 2022-11-22 12:27:09,661 INFO reaped unknown pid 603 2022-11-22T12:27:09.000Z 2022-11-22 12:27:09,661 INFO reaped unknown pid 604 2022-11-22T12:27:09.000Z 2022-11-22 12:27:09,661 INFO reaped unknown pid 604 2022-11-22T12:27:09.000Z 2022-11-22 12:27:09,661 INFO reaped unknown pid 638 2022-11-22T12:27:09.000Z 2022-11-22 12:27:09,661 INFO reaped unknown pid 638 2022-11-22T12:27:10.000Z 2022-11-22 12:27:10,663 INFO reaped unknown pid 608 2022-11-22T12:27:10.000Z 2022-11-22 12:27:10,663 INFO reaped unknown pid 608 2022-11-22T12:27:47.000Z 2022-11-22 12:27:47,707 WARN received SIGTERM indicating exit request 2022-11-22T12:27:47.000Z 2022-11-22 12:27:47,707 WARN received SIGTERM indicating exit request 2022-11-22T12:27:47.000Z 2022-11-22 12:27:47,707 INFO waiting for converter, docservice, metrics, nginx to die 2022-11-22T12:27:47.000Z 2022-11-22 12:27:47,707 INFO waiting for converter, docservice, metrics, nginx to die 2022-11-22T12:27:47.000Z 2022-11-22 12:27:47,717 INFO stopped: nginx (exit status 0) 2022-11-22T12:27:47.000Z 2022-11-22 12:27:47,717 INFO stopped: nginx (exit status 0) 2022-11-22T12:27:47.000Z Flushing stats at Tue Nov 22 2022 12:27:48 GMT+0000 (Coordinated Universal Time)
-
-
@nebulon It seems random to me. Sometimes it's an .xlsx I just created, sometimes a .docx created and opened months ago. Some of the files were created by me and some of them by others. Can't see any specific pattern. Some are working fine and others don't. It's a little weird. I thought clearing the browser-cache could help like in previous Onlyoffice-updates but nothing changed noticeably.
-
2022-11-22T12:25:18.000Z [2022-11-22T12:25:18.568] [ERROR] [localhost] [1302030473] [ocfi59d1h0de_sbosse4] nodeJS - changesError: Error: Uncaught TypeError: Cannot read properties of null (reading 'asc_getSelectionType') Script: https://onlyenterprise.XXXXXXXXX.cloud/7.2.1-34/web-apps/apps/spreadsheeteditor/main/app.js Line: 8:2130357 userAgent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/107.0.0.0 Safari/537.36 platform: Win32 isLoadFullApi: true isDocumentLoadComplete: false StackTrace: TypeError: Cannot read properties of null (reading 'asc_getSelectionType')
This seems to be the part where it fails to open the document.
-
@DSime said in Failing to open documents after Update to Enterprise 7.2.1:
After a rollback to the previous version everything's fine again.
Maybe the issue is upstream? Have you checked with a clean browser without any plugins enabled? Hard to pin down if it's not reproducable but at least we have log output.