Как исправить ошибку загрузки информационной базы?

Question

[AWFX]

При попытке загрузить ИБ на сервер возникает следующая ошибка:

Ошибка загрузки информационной базы. В информационную базу загружены не все данные
по причине:
Ошибка СУБД:
no connection to the server

Причем, другие базы, загружаются без проблем.
Логи (продолжение в комментариях)

spoiler

2023-07-10 12:02:07.379 UTC [752] СООБЩЕНИЕ:  запускается PostgreSQL 15.3 on x86_64-pc-linux-gnu, compiled by gcc (Ubuntu 11.3.0-1ubuntu1~22.04) 11.3.0, 64-bit
2023-07-10 12:02:07.425 UTC [752] СООБЩЕНИЕ:  для приёма подключений по адресу IPv4 "0.0.0.0" открыт порт 5432
2023-07-10 12:02:07.425 UTC [752] СООБЩЕНИЕ:  для приёма подключений по адресу IPv6 "::" открыт порт 5432
2023-07-10 12:02:07.426 UTC [752] СООБЩЕНИЕ:  для приёма подключений открыт Unix-сокет "/tmp/.s.PGSQL.5432"
2023-07-10 12:02:10.853 UTC [942] СООБЩЕНИЕ:  система БД была выключена: 2023-07-10 12:01:27 UTC
2023-07-10 12:02:10.954 UTC [752] СООБЩЕНИЕ:  система БД готова принимать подключения
2023-07-10 12:04:10.295 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: immediate force wait
2023-07-10 12:04:10.326 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 4 (0.0%); добавлено файлов WAL 0, удалено: 0, переработано: 0; запись=0.015 сек., синхр.=0.001 сек., всего=0.032 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=0 kB, ожидалось=0 kB
2023-07-10 12:04:17.446 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: immediate force wait
2023-07-10 12:04:17.454 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 2 (0.0%); добавлено файлов WAL 0, удалено: 0, переработано: 0; запись=0.008 сек., синхр.=0.001 сек., всего=0.009 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=0 kB, ожидалось=0 kB
2023-07-10 12:05:33.950 UTC [1365] ВАЖНО:  база данных "zup_db" не существует
2023-07-10 12:06:11.296 UTC [1302] СООБЩЕНИЕ:  не удалось получить данные от клиента: Connection reset by peer
2023-07-10 12:06:18.238 UTC [1387] ВАЖНО:  база данных "zup_db" не существует
2023-07-10 12:07:26.217 UTC [1428] ВАЖНО:  база данных "zup_db" не существует
2023-07-10 12:07:27.023 UTC [1430] ВАЖНО:  база данных "zup_db" не существует
2023-07-10 12:08:38.972 UTC [1480] ERROR:  syntax error at or near "'plpgsql'" at character 28
2023-07-10 12:08:38.972 UTC [1480] STATEMENT:  CREATE PROCEDURAL LANGUAGE 'plpgsql' HANDLER plpgsql_call_handler
2023-07-10 12:08:38.973 UTC [1480] WARNING:  there is no transaction in progress
2023-07-10 12:14:03.219 UTC [1683] СООБЩЕНИЕ:  очистка "_crg810" пропускается --- блокировка недоступна
2023-07-10 12:14:19.590 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:14:43.325 UTC [1728] СООБЩЕНИЕ:  очистка "_crg874" пропускается --- блокировка недоступна
2023-07-10 12:15:03.339 UTC [1740] СООБЩЕНИЕ:  очистка "_crg874" пропускается --- блокировка недоступна
2023-07-10 12:15:12.182 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 231851 (45.3%); добавлено файлов WAL 0, удалено: 0, переработано: 134; запись=52.506 сек., синхр.=0.001 сек., всего=52.593 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2194092 kB, ожидалось=2194092 kB
2023-07-10 12:15:15.320 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:15:44.884 UTC [1765] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:16:03.362 UTC [1775] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:16:06.687 UTC [1753] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:16:23.353 UTC [1787] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:16:36.294 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 215228 (42.1%); добавлено файлов WAL 0, удалено: 0, переработано: 134; запись=80.964 сек., синхр.=0.001 сек., всего=80.974 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2194916 kB, ожидалось=2194916 kB
2023-07-10 12:16:38.475 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:16:46.324 UTC [1801] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:17:03.689 UTC [1811] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:17:27.226 UTC [1828] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:17:54.276 UTC [1863] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:18:08.286 UTC [1873] СООБЩЕНИЕ:  очистка "_task20" пропускается --- блокировка недоступна
2023-07-10 12:18:17.978 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 166419 (32.5%); добавлено файлов WAL 0, удалено: 0, переработано: 134; запись=98.756 сек., синхр.=0.001 сек., всего=99.504 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2195281 kB, ожидалось=2195281 kB
2023-07-10 12:18:24.535 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:19:43.866 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 185567 (36.3%); добавлено файлов WAL 0, удалено: 0, переработано: 134; запись=77.941 сек., синхр.=0.001 сек., всего=79.331 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2195451 kB, ожидалось=2195451 kB
2023-07-10 12:20:05.026 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:20:56.420 UTC [1955] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:21:16.506 UTC [1968] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:21:36.519 UTC [1975] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:21:56.702 UTC [1988] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:22:16.720 UTC [2002] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:22:36.985 UTC [2015] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:22:56.970 UTC [2021] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:23:10.409 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 137073 (26.8%); добавлено файлов WAL 0, удалено: 0, переработано: 134; запись=185.329 сек., синхр.=0.001 сек., всего=185.384 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2195458 kB, ожидалось=2195458 kB
2023-07-10 12:23:14.890 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:23:21.830 UTC [2041] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:23:41.837 UTC [2047] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:24:01.826 UTC [2055] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:24:21.826 UTC [2064] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:24:41.941 UTC [2076] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:25:01.853 UTC [2082] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:25:20.963 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 192442 (37.6%); добавлено файлов WAL 0, удалено: 0, переработано: 134; запись=125.702 сек., синхр.=0.001 сек., всего=126.074 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2195454 kB, ожидалось=2195458 kB
2023-07-10 12:25:21.877 UTC [2093] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:25:24.994 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:25:42.085 UTC [2107] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:26:01.862 UTC [2112] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:26:21.849 UTC [2119] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:26:41.873 UTC [2139] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:27:01.858 UTC [2145] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:27:18.485 UTC [940] СООБЩЕНИЕ:  контрольная точка завершена: записано буферов: 70612 (13.8%); добавлено файлов WAL 0, удалено: 0, переработано: 134; запись=113.434 сек., синхр.=0.001 сек., всего=113.492 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2195470 kB, ожидалось=2195470 kB
2023-07-10 12:27:21.892 UTC [2157] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:27:23.104 UTC [940] СООБЩЕНИЕ:  начата контрольная точка: wal
2023-07-10 12:27:41.874 UTC [2168] СООБЩЕНИЕ:  очистка "_inforg7823" пропускается --- блокировка недоступна
2023-07-10 12:27:47.280 UTC [752] СООБЩЕНИЕ:  процесс сервера (PID 1647) был завершён по сигналу 11: Segmentation fault

Comments

[AWFX]

Логи:
2023-07-10 12:27:47.280 UTC [752] СООБЩЕНИЕ: завершение всех остальных активных серверных процессов
2023-07-10 12:27:47.668 UTC [752] СООБЩЕНИЕ: все серверные процессы завершены... переинициализация
2023-07-10 12:27:51.244 UTC [2171] СООБЩЕНИЕ: работа системы БД была прервана; последний момент работы: 2023-07-10 12:27:18 UTC
2023-07-10 12:27:51.244 UTC [2171] СООБЩЕНИЕ: система БД была остановлена нештатно; производится автоматическое восстановление
2023-07-10 12:27:51.253 UTC [2174] ВАЖНО: система баз данных в режиме восстановления
2023-07-10 12:27:51.257 UTC [2175] ВАЖНО: система баз данных в режиме восстановления
2023-07-10 12:27:51.269 UTC [2176] ВАЖНО: система баз данных в режиме восстановления
2023-07-10 12:27:51.337 UTC [2171] СООБЩЕНИЕ: запись REDO начинается со смещения E/84023770
2023-07-10 12:27:56.214 UTC [2178] ВАЖНО: система БД ещё не принимает подключения
2023-07-10 12:27:56.214 UTC [2178] ПОДРОБНОСТИ: Согласованное состояние восстановления ещё не достигнуто.
2023-07-10 12:27:56.260 UTC [2179] ВАЖНО: система БД ещё не принимает подключения
2023-07-10 12:27:56.260 UTC [2179] ПОДРОБНОСТИ: Согласованное состояние восстановления ещё не достигнуто.
2023-07-10 12:28:01.383 UTC [2171] СООБЩЕНИЕ: выполняется воспроизведение, прошло времени: 10.04 с, текущий LSN: E/A0117768
2023-07-10 12:28:09.853 UTC [2171] СООБЩЕНИЕ: неожиданный pageaddr E/6D80000 в сегменте журнала 000000010000000F00000023, смещение 14155776
2023-07-10 12:28:09.853 UTC [2171] СООБЩЕНИЕ: записи REDO обработаны до смещения F/23D7CEE0, нагрузка системы: CPU: пользов.: 3.84 с, система: 4.05 с, прошло: 18.55 с
2023-07-10 12:28:09.929 UTC [2172] СООБЩЕНИЕ: начата контрольная точка: end-of-recovery immediate wait
2023-07-10 12:28:19.903 UTC [2181] ВАЖНО: система БД ещё не принимает подключения
2023-07-10 12:28:19.903 UTC [2181] ПОДРОБНОСТИ: Согласованное состояние восстановления ещё не достигнуто.
2023-07-10 12:28:19.907 UTC [2182] ВАЖНО: система БД ещё не принимает подключения
2023-07-10 12:28:19.907 UTC [2182] ПОДРОБНОСТИ: Согласованное состояние восстановления ещё не достигнуто.
2023-07-10 12:28:19.909 UTC [2183] ВАЖНО: система БД ещё не принимает подключения
2023-07-10 12:28:19.909 UTC [2183] ПОДРОБНОСТИ: Согласованное состояние восстановления ещё не достигнуто.
2023-07-10 12:28:22.933 UTC [2172] СООБЩЕНИЕ: контрольная точка завершена: записано буферов: 365257 (71.4%); добавлено файлов WAL 0, удалено: 0, переработано: 159; запись=12.988 сек., синхр.=0.001 сек., всего=13.004 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=2618738 kB, ожидалось=2618738 kB
2023-07-10 12:28:23.091 UTC [752] СООБЩЕНИЕ: система БД готова принимать подключения
2023-07-10 12:43:10.033 UTC [2172] СООБЩЕНИЕ: начата контрольная точка: time
2023-07-10 12:43:35.108 UTC [2172] СООБЩЕНИЕ: контрольная точка завершена: записано буферов: 251 (0.0%); добавлено файлов WAL 0, удалено: 0, переработано: 0; запись=25.074 сек., синхр.=0.001 сек., всего=25.075 сек.; синхронизировано_файлов=0, самая_долгая_синхр.=0.000 сек., средняя=0.000 сек.; расстояние=959 kB, ожидалось=2356960 kB

Answer 1

[AWFX]

Решилось установкой более ранней версии PostgreSQL

Answer 2

[Дмитрий Кинаш]

Наверное после строки

2023-07-10 12:05:33.950 UTC [1365] ВАЖНО: база данных "zup_db" не существует

дальше можно не читать. Бекап разворачивается не в той СУБД, где создавался.

Причем, другие базы, загружаются без проблем.

ХЗ, что там за базы. Может они созданы в этой СУБД и потому с ними все хорошо. Или там полные бекапы, а для ЗУПа сделан разностный (частичный).

Comments

[AWFX]

Все так, эта конфигурация была сделана не на этой СУБД. Однако, другие конфигурации, которые сделаны не в этой СУБД запускаются, но, скорее всего ваши предположения верны.

[Дмитрий Кинаш]

AWFX, при переносе между разными СУБД лучше использовать выгрузку в DT - это не совсем бэкап, но есть гарантия, что получим ту же конфигурацию и те же данные независимо от баз источника и приемника - и не важно что там постгри, дб2, оракл или мс скуль.

[AWFX]

Я как раз загружаю .dt который был создан на microsoft sql. Скорее всего проблема в
2023-07-10 12:08:38.972 UTC [1480] ERROR: syntax error at or near "'plpgsql'" at character 28
2023-07-10 12:08:38.972 UTC [1480] STATEMENT: CREATE PROCEDURAL LANGUAGE 'plpgsql' HANDLER plpgsql_call_handler
2023-07-10 12:08:38.973 UTC [1480] WARNING: there is no transaction in progress

[Дмитрий Кинаш]

AWFX, вы все 1С-патчи поставили?
https://its.1c.ru/db/metod8dev/content/5942/hdoc

[AWFX]

Дмитрий Кинаш, установлена пропатченная версия с сайта https://1c.postgres.ru/. Возможно, стоит попробовать PostgreSQL с оф.сайта 1С

Answer 3

[Константин]

Добавлю:
* разрядность сервера 1С, лучше 32
* проверит № платформы 1С, лучше по новей
* сделать пакетно запустить загрузку