Как исправить ошибку «Некорректный ответ сервера»?

Question

[Ингвар Фон Бьёрк]

При загрузки в любой элемент инфоблока любого файла весом примерно до 5 Мб возникает ошибка "Некорректный ответ сервера". На машинах с ОС Windows проблема появляется крайне редко, на Linux - практически постоянно.

Связался с техподдержкой Битрикс, которая смогла выявить проблему в /bitrix/modules/main/tools/upload.php

$receiver = new \Bitrix\Main\UI\FileInputReceiver($_POST, $_POST["signature"]);

возвращает пустой POST для маленьких файлов. Битрикс посоветовал связаться с хостером. Хостер проблему так и не смог выявить. Техподдержка Битрикса так же слилась.

Собственно теперь настало время обратиться к форумам. Кто-нибудь, что нибудь может подсказать по поводу решения проблемы?

Comments

[Петр Слободянюк]

А что в логах?

[Ярослав Александров]

Очевидно же, что дело не в битриксе, а в сервере. Какой у вас хостинг, тип хостинга (виртуальный тариф, VPS VDS и т.д.)

[Ингвар Фон Бьёрк]

Ярослав Александров, виртуальный, но, как я уже говорил, техподдержка морозиться, говорят, что не могут повторить проблему. Проблема и правда возникает достаточно редко.

Заметил ещё одну фишку - если сбросить кэш страницы, то файл добавляется нормально.

[Ингвар Фон Бьёрк]

Петр Слободянюк, тишина.

sznao.ru 62.192.227.82 - - [06/Nov/2019:10:29:03 +0300] "POST /bitrix/tools/upload.php?lang=ru HTTP/1.0" 200 578 "https://sznao.ru/bitrix/admin/iblock_element_edit.php?IBLOCK_ID=11&type=documents&ID=0&lang=ru&find_section_section=0&IBLOCK_SECTION_ID=0&from=iblock_list_admin" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/77.0.3865.120 Safari/537.36"

[Ярослав Александров]

Ингвар Фон Бьёрк, "Некорректный ответ сервера" - в консоли браузера в ошибках что конкретно пишет при этой ошибке?

[Ингвар Фон Бьёрк]

Ярослав Александров, Как-то так

spoiler

core.js:11491 BX.debug:  [BX.UploaderStream]0: BX.UploaderStreamfiles: {file1573031318756: {…}}file1573031318756: files: Array(1)0: Filecopy: "default"lastModified: 1573028734330lastModifiedDate: Wed Nov 06 2019 11:25:34 GMT+0300 (Москва, стандартное время)__proto__: constructor: ƒ Date()UTC: ƒ UTC()arguments: (...)caller: (...)length: 7name: "UTC"__proto__: ƒ ()[[Scopes]]: Scopes[0]arguments: (...)caller: (...)length: 7name: "Date"now: ƒ now()parse: ƒ parse()prototype: {constructor: ƒ, toString: ƒ, toDateString: ƒ, toTimeString: ƒ, toISOString: ƒ, …}__proto__: ƒ ()[[Scopes]]: Scopes[0]getDate: ƒ getDate()getDay: ƒ getDay()getFullYear: ƒ getFullYear()getHours: ƒ getHours()getMilliseconds: ƒ getMilliseconds()getMinutes: ƒ getMinutes()getMonth: ƒ getMonth()getSeconds: ƒ getSeconds()getTime: ƒ getTime()getTimezoneOffset: ƒ getTimezoneOffset()getUTCDate: ƒ getUTCDate()getUTCDay: ƒ getUTCDay()getUTCFullYear: ƒ getUTCFullYear()getUTCHours: ƒ getUTCHours()getUTCMilliseconds: ƒ getUTCMilliseconds()getUTCMinutes: ƒ getUTCMinutes()getUTCMonth: ƒ getUTCMonth()getUTCSeconds: ƒ getUTCSeconds()getYear: ƒ getYear()setDate: ƒ setDate()setFullYear: ƒ setFullYear()setHours: ƒ setHours()setMilliseconds: ƒ setMilliseconds()setMinutes: ƒ setMinutes()setMonth: ƒ setMonth()setSeconds: ƒ setSeconds()setTime: ƒ setTime()setUTCDate: ƒ setUTCDate()setUTCFullYear: ƒ setUTCFullYear()setUTCHours: ƒ setUTCHours()setUTCMilliseconds: ƒ setUTCMilliseconds()setUTCMinutes: ƒ setUTCMinutes()setUTCMonth: ƒ setUTCMonth()setUTCSeconds: ƒ setUTCSeconds()setYear: ƒ setYear()toDateString: ƒ toDateString()toGMTString: ƒ toUTCString()toISOString: ƒ toISOString()toJSON: ƒ toJSON()toLocaleDateString: ƒ toLocaleDateString()toLocaleString: ƒ toLocaleString()toLocaleTimeString: ƒ toLocaleTimeString()toString: ƒ toString()toTimeString: ƒ toTimeString()toUTCString: ƒ toUTCString()valueOf: ƒ valueOf()Symbol(Symbol.toPrimitive): ƒ [Symbol.toPrimitive]()__proto__: Objectname: "МИНИМУМ.pdf"postName: "default"size: 86976type: "application/pdf"uploadStatus: 4webkitRelativePath: ""__proto__: Filelength: 1__proto__: Array(0)props: {name: "МИНИМУМ.pdf", type: "application/pdf", size: 86976}__proto__: Object__proto__: ObjectfilesCount: 1filesSize: 87020id: "stream0"manager: BX.UploaderStreams {streams: e, killedStreams: e, packages: e, uploaded: BX.Uploader, timeout: 3000, …}pIndex: "pIndex1573031288761"pack: BX.UploaderPackage {filesCount: 1, length: 1, id: "pIndex1573031288761", pIndex: "pIndex1573031288761", limits: {…}, …}postSize: 347xhr: XMLHttpRequest {startTime: 1573031273510, finishTime: 1573031273599, readyState: 4, timeout: 0, onreadystatechange: ƒ, …}_id: 0_onerror: ƒ ()_onfailure: ƒ ()_onprogress: ƒ ()_onsuccess: ƒ ()__proto__: Objectinit: ƒ (e)kill: ƒ ()onerror: ƒ ()onfailure: ƒ (e,t)onprogress: ƒ (e)onsuccess: ƒ (e)restore: ƒ ()send: ƒ (e)xhr: {}__proto__: Objectlength: 1__proto__: Array(0)
core.js:11506 console.trace
J @ core.js:11506
onError @ core_fileinput.min.js?1561728107102703:1
(anonymous) @ core.js:14122
(anonymous) @ core.js:14458
BX.onCustomEvent @ core.js:14451
(anonymous) @ uploader.js:648
(anonymous) @ core.js:14122
(anonymous) @ core.js:14458
BX.onCustomEvent @ core.js:14451
errorStream @ uploader.js:1648
(anonymous) @ core.js:14122
(anonymous) @ core.js:14458
BX.onCustomEvent @ core.js:14451
onfailure @ uploader.js:1774
(anonymous) @ core.js:14122
t.ajax.processRequestData @ core.js:18091
t.ajax.__run @ core.js:17987
e.xhr.onreadystatechange @ core.js:17827
XMLHttpRequest.send (async)
send @ uploader.js:1734
exec @ uploader.js:1348
(anonymous) @ core.js:14122
exec @ uploader.js:1864
start @ uploader.js:1888
init @ uploader.js:1845
start @ uploader.js:1237
checkUploads @ uploader.js:665
start @ uploader.js:657
submit @ uploader.js:481
onAttach @ uploader.js:376
onChange @ uploader.js:400
(anonymous) @ uploader.js:261
(anonymous) @ core.js:14122
(anonymous) @ core.js:14458
BX.onCustomEvent @ core.js:14451
BX.DD.dropFiles._drop @ core_dd.js:137
(anonymous) @ core.js:14122
core.js:11491 BX.debug:  (3) ["processing", {…}, {…}]0: "processing"1: bProactive: falsedata: "<pre>[Bitrix\Main\ArgumentTypeException] ↵The value of an argument 'signedValue' must be of type string (100)↵/home/c/ct70874/bitrix/public_html/bitrix/modules/main/lib/security/sign/signer.php:156↵#0: Bitrix\Main\Security\Sign\Signer-&gt;unsign(NULL, string)↵	/home/c/ct70874/bitrix/public_html/bitrix/modules/main/lib/ui/fileinputreceiver.php:31↵#1: Bitrix\Main\UI\FileInputReceiver-&gt;__construct(array, NULL)↵	/home/c/ct70874/bitrix/public_html/bitrix/modules/main/tools/upload.php:26↵#2: require(string)↵	/home/c/ct70874/bitrix/public_html/bitrix/tools/upload.php:1↵</pre>"type: "json_failure"__proto__: Object2: async: truecache: truedata: FormData {action: "/bitrix/tools/upload.php?lang=ru"}action: "/bitrix/tools/upload.php?lang=ru"__proto__: FormDatadataType: "json"emulateOnload: falseheaders: falsejsonFailure: truejsonProactive: falsejsonResponse: "<pre>[Bitrix\Main\ArgumentTypeException] ↵The value of an argument 'signedValue' must be of type string (100)↵/home/c/ct70874/bitrix/public_html/bitrix/modules/main/lib/security/sign/signer.php:156↵#0: Bitrix\Main\Security\Sign\Signer-&gt;unsign(NULL, string)↵	/home/c/ct70874/bitrix/public_html/bitrix/modules/main/lib/ui/fileinputreceiver.php:31↵#1: Bitrix\Main\UI\FileInputReceiver-&gt;__construct(array, NULL)↵	/home/c/ct70874/bitrix/public_html/bitrix/modules/main/tools/upload.php:26↵#2: require(string)↵	/home/c/ct70874/bitrix/public_html/bitrix/tools/upload.php:1↵</pre>"lsForce: falselsTimeout: 30method: "POST"onerror: ƒ ()onfailure: ƒ ()onsuccess: ƒ ()preparePost: falseprocessData: truescriptsRunFirst: falseskipAuthCheck: truestart: falsetimeout: 900url: "/bitrix/tools/upload.php?lang=ru"xhr: null__proto__: Objectlength: 3__proto__: Array(0)
core.js:11506 console.trace
J @ core.js:11506
(anonymous) @ core.js:14458
BX.onCustomEvent @ core.js:14451
t.ajax.processRequestData @ core.js:18091
t.ajax.__run @ core.js:17987
e.xhr.onreadystatechange @ core.js:17827
XMLHttpRequest.send (async)
send @ uploader.js:1734
exec @ uploader.js:1348
(anonymous) @ core.js:14122
exec @ uploader.js:1864
start @ uploader.js:1888
init @ uploader.js:1845
start @ uploader.js:1237
checkUploads @ uploader.js:665
start @ uploader.js:657
submit @ uploader.js:481
onAttach @ uploader.js:376
onChange @ uploader.js:400
(anonymous) @ uploader.js:261
(anonymous) @ core.js:14122
(anonymous) @ core.js:14458
BX.onCustomEvent @ core.js:14451
BX.DD.dropFiles._drop @ core_dd.js:137
(anonymous) @ core.js:14122

[cybernetic]

Включите php логи, там должен быть ответ.

Погадаем:
1. Возможно ограничение на размер загружаемого файла в php (upload_max_filesize)
2. Возможно ограничение на размер загружаемого файла в nginx, если он стоит (название параметра не помню)

[Ингвар Фон Бьёрк]

cybernetic, ограничение на максимальный размер (upload_max_filesize)? Вряд ли, т.к. вот именно, что файлы больше 5 Мб загружаются.

[Ингвар Фон Бьёрк]

cybernetic, включил стандартные логи в битриксе, там все глухо по части загрузки.

[cybernetic]

Ингвар Фон Бьёрк, Проверьте логи php для надежности, добавьте в dbconn.php

ini_set("display_errors", 1);
ini_set("display_startup_errors", 1);

ini_set("error_reporting", E_ALL);
ini_set("error_log", $_SERVER["DOCUMENT_ROOT"].'/_errors.log');

если там будет пусто, то смотрите доходит ли ваш запрос до битрикса вобще. Может его nginx выше режет.

[Айнур Валиев]

настройки php.ini, upload_max_size, post_max_size, а также в nginx

[Ингвар Фон Бьёрк]

cybernetic, долго я отвечал, но все же:

2019-11-25 10:47:44 - Host: sznao.ru - UNCAUGHT_EXCEPTION - [Bitrix\Main\ArgumentTypeException] 
The value of an argument 'signedValue' must be of type string (100)
/home/c/ct70874/bitrix/public_html/bitrix/modules/main/lib/security/sign/signer.php:156
#0: Bitrix\Main\Security\Sign\Signer->unsign(NULL, string)
	/home/c/ct70874/bitrix/public_html/bitrix/modules/main/lib/ui/fileinputreceiver.php:31
#1: Bitrix\Main\UI\FileInputReceiver->__construct(array, NULL)
	/home/c/ct70874/bitrix/public_html/bitrix/modules/main/tools/upload.php:26
#2: require(string)
	/home/c/ct70874/bitrix/public_html/bitrix/tools/upload.php:1

Странно, то ошибка возникает только для маленьких файлов.
В Bitrix\Main\UI\FileInputReceiver->__construct() вызывается с переменной $signature = POST["signature"], а POST["signature"] == NULL. Теперь внимание, вопрос: где именно задается значение POST["signature"]? Раз уж особо решения я не вижу, то в теории, можно подменить POST["signature"] на какую нибудь константу. В ядро лезть конечно нехорошо, но как-то входа не вижу.

Answer 1

[Ингвар Фон Бьёрк]

Проблема заключалась в том, что когда-то на сайте создавался ServiceWorker для отображения страницы без подключения к интернету. Этот сервис воркер грузил в фоне кучу левых файлов и предыдущие $_POST, т.к. ошибку выбивало именно из-за того, что $_POST['signature'] == NULL. Именно по этому сброс кэша страницы позволял загрузить файл.
Решил проблему простым отключение ServiceWorker для админской части.