ESXI + Ubuntu + xRDP + 1С: зависает печать (ESXI 6.7, Ubuntu 18.04, 1С 8.3.13.1644, CUPS-сервер 2.27, печать из 1С зависает намертво)

Модераторы: dimbor, Модераторы разделов

Ответить
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Добрый день.

ESXI 6.7, Ubuntu 18.04, 1С 8.3.13.1644, CUPS-сервер 2.27 (/etc/cups/client.conf на терминалке). Сервер 1С работает на отдельной виртуалке, на Ubuntu 18.04 + PostgreSQL 10. Терминальный сервер на Ubuntu 18.04, xRDP, Mate. Всё хозяйство перенесено со старого сервера на Proxmox+LXC. Там печать работала.
1С стабильно зависает при попытке распечатать документ. Из любой конфигурации, на принтер любой фирмы: выводит окно отправки задания на печать — и всё. Точнее, зависает, если открывать Файл-Печать или жать «CTRL-P». При нажатии кнопки «Печать» над печатной формой документа («CTRL-SHIFT-P»), печать обычно работает. Печать в файл работает. Если открыть параметры страницы, кнопка «Принтер» не срабатывает, свойства принтера не открываются.
Из других приложений в терминалке печать работает.

Пробовал переустанавливать CUPS, пробовал подключаться к старому CUPS-серверу, с которого печать работала до переезда на новый, пробовал отключиться от CUPS-сервера и настроить принтеры прямо на терминалке. Пробовал поставить HPLIP и повесить его в трее у клиента (у кого-то так работало). Обновлял конфигурации 1С и платформу. Пробовал сбросить изменения в табличных формах (т.е. их не было, так что я сначала менял форму, потом откатывался на типовую), т.к. говорят, это может помочь. Наверное, делал ещё что-то, но уже не помню.

Обычно окно отправки задания не отрисовывалось, даже правая граница не дорисовывалась, только какие-то фрагменты фона, на котором окно открылось. После того, как понастраивал терминалку (1С ругалась на доступ к временным файлам) по статье с Хабра, указав в /etc/login.defs

Код: Выделить всё

umask 002
и изменив права на /tmp:

Код: Выделить всё

chown -R root:users /tmp
chmod g+s /tmp
, окно внезапно начало сначала полностью отрисовываться, а только потом зависать :) Права на /tmp после перезагрузки не сохранились:

Код: Выделить всё

drwxrwxrwt
Когда отправляю задание на печать, в папке /tmp появляется файл:

Код: Выделить всё

-rw------- 1 <пользователь> <группа-пользователя> 0 wxPrintPS_IFN0XZ
Фантазия закончилась, где копать — не знаю.
С уважением.
Спасибо сказали:
Аватара пользователя
Bizdelnick
Модератор
Сообщения: 20752
Статус: nulla salus bello
ОС: Debian GNU/Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение Bizdelnick »

makus писал:
28.02.2019 16:55
Пробовал переустанавливать CUPS, пробовал подключаться к старому CUPS-серверу, с которого печать работала до переезда на новый, пробовал отключиться от CUPS-сервера и настроить принтеры прямо на терминалке. Пробовал поставить HPLIP и повесить его в трее у клиента (у кого-то так работало). Обновлял конфигурации 1С и платформу. Пробовал сбросить изменения в табличных формах (т.е. их не было, так что я сначала менял форму, потом откатывался на типовую), т.к. говорят, это может помочь. Наверное, делал ещё что-то, но уже не помню.
А логи CUPS посмотреть не пробовали? И на клиенте, и на сервере.
Пишите правильно:
в консоли
вку́пе (с чем-либо)
в общем
вообще
в течение (часа)
новичок
нюанс
по умолчанию
приемлемо
проблема
пробовать
трафик
Спасибо сказали:
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Bizdelnick писал:
28.02.2019 17:19
А логи CUPS посмотреть не пробовали? И на клиенте, и на сервере.
На сервере:
Spoiler
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 28] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:02 +0300] [Client 28] Accepted from 172.25.248.97:44742 (IPv4)
D [28/Feb/2019:18:21:02 +0300] [Client 28] Waiting for request.
I [28/Feb/2019:18:21:02 +0300] Expiring subscriptions...
D [28/Feb/2019:18:21:02 +0300] Report: clients=4
D [28/Feb/2019:18:21:02 +0300] Report: jobs=499
D [28/Feb/2019:18:21:02 +0300] Report: jobs-active=0
D [28/Feb/2019:18:21:02 +0300] Report: printers=7
D [28/Feb/2019:18:21:02 +0300] Report: stringpool-string-count=61482
D [28/Feb/2019:18:21:02 +0300] Report: stringpool-alloc-bytes=19536
D [28/Feb/2019:18:21:02 +0300] Report: stringpool-total-bytes=1091824
D [28/Feb/2019:18:21:02 +0300] [Client 28] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:02 +0300] [Client 28] Closing connection.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 29] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:02 +0300] [Client 29] Accepted from 172.25.248.97:44744 (IPv4)
D [28/Feb/2019:18:21:02 +0300] [Client 29] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] [Client 29] POST / HTTP/1.1
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=200, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] No authentication data provided.
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] Read: status=100, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 29] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:02 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:02 +0300] [Client 29] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:02 +0300] [Client 29] Content-Length: 6240
D [28/Feb/2019:18:21:02 +0300] [Client 29] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:02 +0300] [Client 29] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:02 +0300] [Client 29] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c527ac0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:02 +0300] [Client 29] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:02 +0300] [Client 29] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:02 +0300] [Client 29] Flushing write buffer.
D [28/Feb/2019:18:21:02 +0300] [Client 29] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:02 +0300] [Client 29] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 30] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:02 +0300] [Client 30] Accepted from 172.25.248.97:44748 (IPv4)
D [28/Feb/2019:18:21:02 +0300] [Client 30] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] [Client 29] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:02 +0300] [Client 29] Closing connection.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] [Client 30] GET /printers/HP_LaserJet_M425dn_Buh.ppd HTTP/1.1
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 30] Read: status=200, state=3
D [28/Feb/2019:18:21:02 +0300] [Client 30] No authentication data provided.
D [28/Feb/2019:18:21:02 +0300] [Client 30] Processing GET /printers/HP_LaserJet_M425dn_Buh.ppd
D [28/Feb/2019:18:21:02 +0300] [Client 30] filename="/etc/cups/ppd/HP_LaserJet_M425dn_Buh.ppd", type=application/vnd.cups-ppd
D [28/Feb/2019:18:21:02 +0300] [Client 30] cupsdSendHeader: code=200, type="application/vnd.cups-ppd", auth_type=0
D [28/Feb/2019:18:21:02 +0300] [Client 30] Sending file.
D [28/Feb/2019:18:21:02 +0300] [Client 30] con->http=0x55c56c558bd0
D [28/Feb/2019:18:21:02 +0300] [Client 30] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=9224, response=(nil)(), pipe_pid=0, file=12
D [28/Feb/2019:18:21:02 +0300] [Client 30] con->http=0x55c56c558bd0
D [28/Feb/2019:18:21:02 +0300] [Client 30] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=9224, response=(nil)(), pipe_pid=0, file=12
D [28/Feb/2019:18:21:02 +0300] [Client 30] con->http=0x55c56c558bd0
D [28/Feb/2019:18:21:02 +0300] [Client 30] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=9224, response=(nil)(), pipe_pid=0, file=12
D [28/Feb/2019:18:21:02 +0300] [Client 30] con->http=0x55c56c558bd0
D [28/Feb/2019:18:21:02 +0300] [Client 30] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=9224, response=(nil)(), pipe_pid=0, file=12
D [28/Feb/2019:18:21:02 +0300] [Client 30] con->http=0x55c56c558bd0
D [28/Feb/2019:18:21:02 +0300] [Client 30] cupsdWriteClient error=0, used=0, state=HTTP_STATE_GET_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=9224, response=(nil)(), pipe_pid=0, file=12
D [28/Feb/2019:18:21:02 +0300] [Client 30] Flushing write buffer.
D [28/Feb/2019:18:21:02 +0300] [Client 30] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:02 +0300] [Client 30] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] [Client 30] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:02 +0300] [Client 30] Closing connection.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 31] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:02 +0300] [Client 31] Accepted from 172.25.248.97:44750 (IPv4)
D [28/Feb/2019:18:21:02 +0300] [Client 31] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] [Client 31] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:02 +0300] [Client 31] Closing connection.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 32] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:02 +0300] [Client 32] Accepted from 172.25.248.97:44752 (IPv4)
D [28/Feb/2019:18:21:02 +0300] [Client 32] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] [Client 32] POST / HTTP/1.1
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] [Client 32] Read: status=200, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 32] No authentication data provided.
D [28/Feb/2019:18:21:02 +0300] [Client 32] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:02 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:02 +0300] [Client 32] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:02 +0300] [Client 32] Content-Length: 6240
D [28/Feb/2019:18:21:02 +0300] [Client 32] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:02 +0300] [Client 32] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:02 +0300] [Client 32] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c54d2e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:02 +0300] [Client 32] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:02 +0300] [Client 32] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:02 +0300] [Client 32] Flushing write buffer.
D [28/Feb/2019:18:21:02 +0300] [Client 32] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:02 +0300] [Client 32] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] [Client 32] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:02 +0300] [Client 32] Closing connection.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 33] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:02 +0300] [Client 33] Accepted from 172.25.248.97:44754 (IPv4)
D [28/Feb/2019:18:21:02 +0300] [Client 33] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] [Client 33] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:02 +0300] [Client 33] Closing connection.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:02 +0300] [Client 34] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:02 +0300] [Client 34] Accepted from 172.25.248.97:44756 (IPv4)
D [28/Feb/2019:18:21:02 +0300] [Client 34] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] [Client 34] POST / HTTP/1.1
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] [Client 34] Read: status=200, state=6
D [28/Feb/2019:18:21:02 +0300] [Client 34] No authentication data provided.
D [28/Feb/2019:18:21:02 +0300] [Client 34] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:02 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:02 +0300] [Client 34] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:02 +0300] [Client 34] Content-Length: 6240
D [28/Feb/2019:18:21:02 +0300] [Client 34] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:02 +0300] [Client 34] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:02 +0300] [Client 34] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c5249c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:02 +0300] [Client 34] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:02 +0300] [Client 34] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:02 +0300] [Client 34] Flushing write buffer.
D [28/Feb/2019:18:21:02 +0300] [Client 34] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:02 +0300] [Client 34] Waiting for request.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:02 +0300] [Client 34] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:02 +0300] [Client 34] Closing connection.
D [28/Feb/2019:18:21:02 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] [Client 35] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:03 +0300] [Client 35] Accepted from 172.25.248.97:44758 (IPv4)
D [28/Feb/2019:18:21:03 +0300] [Client 35] Waiting for request.
D [28/Feb/2019:18:21:03 +0300] [Client 35] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:03 +0300] [Client 35] Closing connection.
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
I [28/Feb/2019:18:21:03 +0300] Expiring subscriptions...
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] [Client 36] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:03 +0300] [Client 36] Accepted from 172.25.248.97:44760 (IPv4)
D [28/Feb/2019:18:21:03 +0300] [Client 36] Waiting for request.
D [28/Feb/2019:18:21:03 +0300] [Client 36] POST / HTTP/1.1
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:03 +0300] [Client 36] Read: status=200, state=6
D [28/Feb/2019:18:21:03 +0300] [Client 36] No authentication data provided.
D [28/Feb/2019:18:21:03 +0300] [Client 36] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:03 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:03 +0300] [Client 36] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:03 +0300] [Client 36] Content-Length: 6240
D [28/Feb/2019:18:21:03 +0300] [Client 36] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:03 +0300] [Client 36] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:03 +0300] [Client 36] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c545b40(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:03 +0300] [Client 36] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:03 +0300] [Client 36] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:03 +0300] [Client 36] Flushing write buffer.
D [28/Feb/2019:18:21:03 +0300] [Client 36] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:03 +0300] [Client 36] Waiting for request.
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:03 +0300] [Client 36] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:03 +0300] [Client 36] Closing connection.
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] [Client 37] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:03 +0300] [Client 37] Accepted from 172.25.248.97:44762 (IPv4)
D [28/Feb/2019:18:21:03 +0300] [Client 37] Waiting for request.
D [28/Feb/2019:18:21:03 +0300] [Client 37] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:03 +0300] [Client 37] Closing connection.
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] [Client 38] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:03 +0300] [Client 38] Accepted from 172.25.248.97:44764 (IPv4)
D [28/Feb/2019:18:21:03 +0300] [Client 38] Waiting for request.
D [28/Feb/2019:18:21:03 +0300] [Client 38] POST / HTTP/1.1
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:03 +0300] [Client 38] Read: status=200, state=6
D [28/Feb/2019:18:21:03 +0300] [Client 38] No authentication data provided.
D [28/Feb/2019:18:21:03 +0300] [Client 38] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:03 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:03 +0300] [Client 38] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:03 +0300] [Client 38] Content-Length: 6240
D [28/Feb/2019:18:21:03 +0300] [Client 38] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:03 +0300] [Client 38] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:03 +0300] [Client 38] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c530980(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:03 +0300] [Client 38] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:03 +0300] [Client 38] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:03 +0300] [Client 38] Flushing write buffer.
D [28/Feb/2019:18:21:03 +0300] [Client 38] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:03 +0300] [Client 38] Waiting for request.
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:03 +0300] [Client 38] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:03 +0300] [Client 38] Closing connection.
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:03 +0300] [Client 39] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:03 +0300] [Client 39] Accepted from 172.25.248.97:44766 (IPv4)
D [28/Feb/2019:18:21:03 +0300] [Client 39] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] [Client 39] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:04 +0300] [Client 39] Closing connection.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
I [28/Feb/2019:18:21:04 +0300] Expiring subscriptions...
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:04 +0300] [Client 40] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:04 +0300] [Client 40] Accepted from 172.25.248.97:44768 (IPv4)
D [28/Feb/2019:18:21:04 +0300] [Client 40] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] [Client 40] POST / HTTP/1.1
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] [Client 40] Read: status=200, state=6
D [28/Feb/2019:18:21:04 +0300] [Client 40] No authentication data provided.
D [28/Feb/2019:18:21:04 +0300] [Client 40] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:04 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:04 +0300] [Client 40] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:04 +0300] [Client 40] Content-Length: 6240
D [28/Feb/2019:18:21:04 +0300] [Client 40] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:04 +0300] [Client 40] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:04 +0300] [Client 40] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c527ac0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:04 +0300] [Client 40] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:04 +0300] [Client 40] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:04 +0300] [Client 40] Flushing write buffer.
D [28/Feb/2019:18:21:04 +0300] [Client 40] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:04 +0300] [Client 40] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] [Client 40] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:04 +0300] [Client 40] Closing connection.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:04 +0300] [Client 41] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:04 +0300] [Client 41] Accepted from 172.25.248.97:44770 (IPv4)
D [28/Feb/2019:18:21:04 +0300] [Client 41] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] [Client 41] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:04 +0300] [Client 41] Closing connection.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:04 +0300] [Client 42] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:04 +0300] [Client 42] Accepted from 172.25.248.97:44772 (IPv4)
D [28/Feb/2019:18:21:04 +0300] [Client 42] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] [Client 42] POST / HTTP/1.1
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] [Client 42] Read: status=200, state=6
D [28/Feb/2019:18:21:04 +0300] [Client 42] No authentication data provided.
D [28/Feb/2019:18:21:04 +0300] [Client 42] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:04 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:04 +0300] [Client 42] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:04 +0300] [Client 42] Content-Length: 6240
D [28/Feb/2019:18:21:04 +0300] [Client 42] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:04 +0300] [Client 42] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:04 +0300] [Client 42] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c54d2e0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:04 +0300] [Client 42] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:04 +0300] [Client 42] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:04 +0300] [Client 42] Flushing write buffer.
D [28/Feb/2019:18:21:04 +0300] [Client 42] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:04 +0300] [Client 42] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] [Client 42] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:04 +0300] [Client 42] Closing connection.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:04 +0300] [Client 43] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:04 +0300] [Client 43] Accepted from 172.25.248.97:44774 (IPv4)
D [28/Feb/2019:18:21:04 +0300] [Client 43] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] [Client 43] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:04 +0300] [Client 43] Closing connection.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:04 +0300] [Client 44] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:04 +0300] [Client 44] Accepted from 172.25.248.97:44776 (IPv4)
D [28/Feb/2019:18:21:04 +0300] [Client 44] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] [Client 44] POST / HTTP/1.1
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] [Client 44] Read: status=200, state=6
D [28/Feb/2019:18:21:04 +0300] [Client 44] No authentication data provided.
D [28/Feb/2019:18:21:04 +0300] [Client 44] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:04 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:04 +0300] [Client 44] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:04 +0300] [Client 44] Content-Length: 6240
D [28/Feb/2019:18:21:04 +0300] [Client 44] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:04 +0300] [Client 44] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:04 +0300] [Client 44] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c5249c0(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:04 +0300] [Client 44] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:04 +0300] [Client 44] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:04 +0300] [Client 44] Flushing write buffer.
D [28/Feb/2019:18:21:04 +0300] [Client 44] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:04 +0300] [Client 44] Waiting for request.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:04 +0300] [Client 44] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:04 +0300] [Client 44] Closing connection.
D [28/Feb/2019:18:21:04 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] [Client 45] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:05 +0300] [Client 45] Accepted from 172.25.248.97:44778 (IPv4)
D [28/Feb/2019:18:21:05 +0300] [Client 45] Waiting for request.
I [28/Feb/2019:18:21:05 +0300] Expiring subscriptions...
D [28/Feb/2019:18:21:05 +0300] [Client 45] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:05 +0300] [Client 45] Closing connection.
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] [Client 46] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:05 +0300] [Client 46] Accepted from 172.25.248.97:44780 (IPv4)
D [28/Feb/2019:18:21:05 +0300] [Client 46] Waiting for request.
D [28/Feb/2019:18:21:05 +0300] [Client 46] POST / HTTP/1.1
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:05 +0300] [Client 46] Read: status=200, state=6
D [28/Feb/2019:18:21:05 +0300] [Client 46] No authentication data provided.
D [28/Feb/2019:18:21:05 +0300] [Client 46] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:05 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:05 +0300] [Client 46] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:05 +0300] [Client 46] Content-Length: 6240
D [28/Feb/2019:18:21:05 +0300] [Client 46] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:05 +0300] [Client 46] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:05 +0300] [Client 46] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c545b40(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:05 +0300] [Client 46] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:05 +0300] [Client 46] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:05 +0300] [Client 46] Flushing write buffer.
D [28/Feb/2019:18:21:05 +0300] [Client 46] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:05 +0300] [Client 46] Waiting for request.
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:05 +0300] [Client 46] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:05 +0300] [Client 46] Closing connection.
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] [Client 47] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:05 +0300] [Client 47] Accepted from 172.25.248.97:44782 (IPv4)
D [28/Feb/2019:18:21:05 +0300] [Client 47] Waiting for request.
D [28/Feb/2019:18:21:05 +0300] [Client 47] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:05 +0300] [Client 47] Closing connection.
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] [Client 48] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:05 +0300] [Client 48] Accepted from 172.25.248.97:44784 (IPv4)
D [28/Feb/2019:18:21:05 +0300] [Client 48] Waiting for request.
D [28/Feb/2019:18:21:05 +0300] [Client 48] POST / HTTP/1.1
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:05 +0300] [Client 48] Read: status=200, state=6
D [28/Feb/2019:18:21:05 +0300] [Client 48] No authentication data provided.
D [28/Feb/2019:18:21:05 +0300] [Client 48] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:05 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:05 +0300] [Client 48] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from 172.25.248.97
D [28/Feb/2019:18:21:05 +0300] [Client 48] Content-Length: 6240
D [28/Feb/2019:18:21:05 +0300] [Client 48] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:05 +0300] [Client 48] con->http=0x55c56c5515f0
D [28/Feb/2019:18:21:05 +0300] [Client 48] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=6240, response=0x55c56c530980(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:05 +0300] [Client 48] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:05 +0300] [Client 48] bytes=0, http_state=0, data_remaining=6240
D [28/Feb/2019:18:21:05 +0300] [Client 48] Flushing write buffer.
D [28/Feb/2019:18:21:05 +0300] [Client 48] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:05 +0300] [Client 48] Waiting for request.
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:05 +0300] [Client 48] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:05 +0300] [Client 48] Closing connection.
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:05 +0300] [Client 49] Server address is "172.25.248.98".
D [28/Feb/2019:18:21:05 +0300] [Client 49] Accepted from 172.25.248.97:44786 (IPv4)
D [28/Feb/2019:18:21:05 +0300] [Client 49] Waiting for request.
I [28/Feb/2019:18:21:06 +0300] Expiring subscriptions...
D [28/Feb/2019:18:21:31 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:31 +0300] [Client 50] Server address is "/var/run/cups/cups.sock".
D [28/Feb/2019:18:21:31 +0300] [Client 50] Accepted from localhost (Domain)
D [28/Feb/2019:18:21:31 +0300] [Client 50] Waiting for request.
I [28/Feb/2019:18:21:31 +0300] Expiring subscriptions...
D [28/Feb/2019:18:21:31 +0300] [Client 50] POST / HTTP/1.1
D [28/Feb/2019:18:21:31 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Active clients"
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=200, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] No authentication data provided.
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] 2.0 CUPS-Get-Printers 1
D [28/Feb/2019:18:21:31 +0300] CUPS-Get-Printers
D [28/Feb/2019:18:21:31 +0300] [Client 50] Returning IPP successful-ok for CUPS-Get-Printers (no URI) from localhost
D [28/Feb/2019:18:21:31 +0300] [Client 50] Content-Length: 71947
D [28/Feb/2019:18:21:31 +0300] [Client 50] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:31 +0300] [Client 50] con->http=0x55c56c558bd0
D [28/Feb/2019:18:21:31 +0300] [Client 50] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=71947, response=0x55c56c524990(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:31 +0300] [Client 50] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:31 +0300] [Client 50] bytes=0, http_state=0, data_remaining=71947
D [28/Feb/2019:18:21:31 +0300] [Client 50] Flushing write buffer.
D [28/Feb/2019:18:21:31 +0300] [Client 50] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:31 +0300] [Client 50] Waiting for request.
D [28/Feb/2019:18:21:31 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:31 +0300] [Client 50] POST / HTTP/1.1
D [28/Feb/2019:18:21:31 +0300] cupsdSetBusyState: newbusy="Active clients", busy="Not busy"
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=200, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] No authentication data provided.
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] Read: status=100, state=6
D [28/Feb/2019:18:21:31 +0300] [Client 50] 2.0 CUPS-Get-Classes 1
D [28/Feb/2019:18:21:31 +0300] CUPS-Get-Classes
D [28/Feb/2019:18:21:31 +0300] [Client 50] Returning IPP successful-ok for CUPS-Get-Classes (no URI) from localhost
D [28/Feb/2019:18:21:31 +0300] [Client 50] Content-Length: 75
D [28/Feb/2019:18:21:31 +0300] [Client 50] cupsdSendHeader: code=200, type="application/ipp", auth_type=0
D [28/Feb/2019:18:21:31 +0300] [Client 50] con->http=0x55c56c558bd0
D [28/Feb/2019:18:21:31 +0300] [Client 50] cupsdWriteClient error=0, used=0, state=HTTP_STATE_POST_SEND, data_encoding=HTTP_ENCODING_LENGTH, data_remaining=75, response=0x55c56c567050(IPP_STATE_DATA), pipe_pid=0, file=-1
D [28/Feb/2019:18:21:31 +0300] [Client 50] Writing IPP response, ipp_state=IPP_STATE_DATA, old wused=0, new wused=0
D [28/Feb/2019:18:21:31 +0300] [Client 50] bytes=0, http_state=0, data_remaining=75
D [28/Feb/2019:18:21:31 +0300] [Client 50] Flushing write buffer.
D [28/Feb/2019:18:21:31 +0300] [Client 50] New state is HTTP_STATE_WAITING
D [28/Feb/2019:18:21:31 +0300] [Client 50] Waiting for request.
D [28/Feb/2019:18:21:31 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Active clients"
D [28/Feb/2019:18:21:31 +0300] [Client 50] HTTP_STATE_WAITING Closing for error 32 (Broken pipe)
D [28/Feb/2019:18:21:31 +0300] [Client 50] Closing connection.
D [28/Feb/2019:18:21:31 +0300] cupsdSetBusyState: newbusy="Not busy", busy="Not busy"
I [28/Feb/2019:18:21:32 +0300] Expiring subscriptions...
На клиенте лог пустой (LogLevel debug).
Добавлено (18:34):
Система везде 64-битная, если это имеет значение.
Добавлено (18:46):
Client 30, если я правильно понимаю. И я пробовал разные драйверы, в том числе и generic, проблема печати из 1С не решалась (из других программ печатает).
С уважением.
Спасибо сказали:
Аватара пользователя
Bizdelnick
Модератор
Сообщения: 20752
Статус: nulla salus bello
ОС: Debian GNU/Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение Bizdelnick »

А какая версия CUPS на клиенте? Вот это — не Ваш случай? Видимо, не Ваш, раз и на клиенте, и на сервере Ubuntu 18.04.
Хотя по такой ошибке много разного находится, вплоть до нерабочего USB-порта/кабеля.
Пишите правильно:
в консоли
вку́пе (с чем-либо)
в общем
вообще
в течение (часа)
новичок
нюанс
по умолчанию
приемлемо
проблема
пробовать
трафик
Спасибо сказали:
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Bizdelnick писал:
28.02.2019 18:52
А какие версии CUPS на сервере и на клиенте? Вот это — не Ваш случай?
Хотя по такой ошибке много разного находится, вплоть до нерабочего USB-порта/кабеля.
CUPS 2.27 на обеих виртуалках, cups-browsed был мёртв. Перезапустил и на сервере, и на клиенте — не помогло.

Забыл уточнить: принтер сетевой, подключение настроено вот так:

Код: Выделить всё

hp:/net/HP_LaserJet_400_MFP_M425dn?ip=172.25.248.8
С уважением.
Спасибо сказали:
Аватара пользователя
Bizdelnick
Модератор
Сообщения: 20752
Статус: nulla salus bello
ОС: Debian GNU/Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение Bizdelnick »

makus писал:
28.02.2019 19:01
Забыл уточнить: принтер сетевой, подключение настроено вот так:

Код: Выделить всё

hp:/net/HP_LaserJet_400_MFP_M425dn?ip=172.25.248.8
А разве сетевое подключение так настраивается? По идее должно быть что-то вроде

Код: Выделить всё

socket://172.25.248.8
Хотя, может быть, у этого принтера всё по-другому, не знаю.
Пишите правильно:
в консоли
вку́пе (с чем-либо)
в общем
вообще
в течение (часа)
новичок
нюанс
по умолчанию
приемлемо
проблема
пробовать
трафик
Спасибо сказали:
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Так hplip настроил. Но я поменял на «socket://» — проблема осталась.
С уважением.
Спасибо сказали:
Аватара пользователя
Bizdelnick
Модератор
Сообщения: 20752
Статус: nulla salus bello
ОС: Debian GNU/Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение Bizdelnick »

А, да, ему таки нужен плагин. Я таких принтеров не настраивал, но, видимо, таки правильно hp:.
Итого, что получается. Похоже, 1С запрашивает какую-то инфу о принтере, которую CUPS не удаётся получить. Очевидно, проблема на стороне сервера.
А печатать напрямую на принтер пробовали, раз уж он сетевой? Вы это подразумевали под
makus писал:
28.02.2019 16:55
поставить HPLIP и повесить его в трее у клиента
?
Пишите правильно:
в консоли
вку́пе (с чем-либо)
в общем
вообще
в течение (часа)
новичок
нюанс
по умолчанию
приемлемо
проблема
пробовать
трафик
Спасибо сказали:
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Bizdelnick писал:
28.02.2019 21:07
Итого, что получается. Похоже, 1С запрашивает какую-то инфу о принтере, которую CUPS не удаётся получить. Очевидно, проблема на стороне сервера.
Если печатать из 1С прямо на принтер (кнопка над табличной формой или Ctrl-Shift-P), документ печатается. Не помню насчёт форматирования, запоминаются ли так пользовательские настройки, но печатается.
Если же нажимать Файл-Печать или Ctrl-P, открывается системное окно печати документа. После нажатия в этом окне кнопки печати, системное окно закрывается, открывается окно отправки документа на печать в 1С и зависает так, что и кнопка «Отмена» не работает.
Попытка отправить документ на печать.
Попытка отправить документ на печать.
Открылось системное (Ubuntu Mate) окно печати.
Открылось системное (Ubuntu Mate) окно печати.
1С зависла, это окно отправки задания на печать не реагирует на команды, как и 1С.
1С зависла, это окно отправки задания на печать не реагирует на команды, как и 1С.
Bizdelnick писал:
28.02.2019 21:07
А печатать напрямую на принтер пробовали, раз уж он сетевой? Вы это подразумевали?
Пробовал отключиться от сервера и настроить принтеры прямо на терминалке. Проблема сохранилась.

Я тут где-то находил упоминание, что если заменить формат задания в 1С с postscript на pdf, всё может заработать. Проблема в том, что я не могу изменить в 1С настройки принтера, т.к. по нажатию кнопки «Принтер» в настройке параметров печати, ничего не происходит.
С уважением.
Спасибо сказали:
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Попробовал снова настроить принтер локально, на терминалке. Добавил его с помощью hplip, но ничего не изменилось. Проблема осталась.
С уважением.
Спасибо сказали:
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Созданная в 1С пустая таблица распечаталась без проблем, сохранённый в mxl и отправленный на печать файл документа из 1С завис, сохранённый в pdf и в xlsx документ, распечатанный из pdf-вьюера и из OnlyOffice соответственно, напечатались без проблем.
С уважением.
Спасибо сказали:
Аватара пользователя
makus
Сообщения: 48
ОС: Linux

Re: ESXI + Ubuntu + xRDP + 1С: зависает печать

Сообщение makus »

Переписывался с разработчиками 1С. Кажется, проблема решена в тестовой версии платформы 8.3.13.1827. По крайней мере, я провёл тесты с разными Бухгалтериями 3.0, разных версий, и печать заработала. На два разных принтера.
Правда, свойства принтера из настроек печати всё равно не открываются, но это уже не так страшно.

Жду релиза этой версии платформы.
С уважением.
Спасибо сказали:
Ответить