secondary.log

application/octet-stream

Download

2023-10-02 10:21:19.112 UTC [953] LOG:  starting PostgreSQL 17devel on x86_64-linux, compiled by gcc-8.3.1, 64-bit
2023-10-02 10:21:19.113 UTC [953] LOG:  listening on IPv6 address "::1", port 5432
2023-10-02 10:21:19.113 UTC [953] LOG:  listening on IPv4 address "127.0.0.1", port 5432
2023-10-02 10:21:19.117 UTC [953] LOG:  listening on Unix socket "/tmp/.s.PGSQL.5432"
2023-10-02 10:21:19.123 UTC [956] LOG:  database system was interrupted; last known up at 2023-10-02 10:21:18 UTC
2023-10-02 10:21:19.218 UTC [956] LOG:  entering standby mode
2023-10-02 10:21:19.222 UTC [956] LOG:  redo starts at 0/2000028
2023-10-02 10:21:19.224 UTC [956] LOG:  consistent recovery state reached at 0/2000100
2023-10-02 10:21:19.224 UTC [953] LOG:  database system is ready to accept read-only connections
2023-10-02 10:21:19.234 UTC [959] LOG:  started streaming WAL from primary at 0/3000000 on timeline 1
2023-10-02 10:21:19.323 UTC [965] LOG:  duration: 6.871 ms  statement: SELECT * FROM pg_create_physical_replication_slot('physical');
2023-10-02 10:21:22.960 UTC [953] LOG:  received SIGHUP, reloading configuration files
2023-10-02 10:21:22.969 UTC [999] LOG:  Replication slot-sync worker 0 started
2023-10-02 10:21:22.978 UTC [958] LOG:  Added database 5 to replication slot-sync worker 0; dbcount now: 1
2023-10-02 10:21:22.991 UTC [999] LOG:  waiting for remote slot "sub" LSN (0/3000060) and catalog xmin (734) to pass local slot LSN (0/30000D0) and and catalog xmin (734)
2023-10-02 10:21:23.980 UTC [1002] LOG:  duration: 6.240 ms  statement: SELECT * FROM pg_replication_slots;
2023-10-02 10:21:36.042 UTC [959] FATAL:  could not receive data from WAL stream: server closed the connection unexpectedly
		This probably means the server terminated abnormally
		before or while processing the request.
2023-10-02 10:21:36.042 UTC [956] LOG:  invalid record length at 0/30003C0: expected at least 24, got 0
2023-10-02 10:21:36.045 UTC [999] ERROR:  could not fetch slot info for slot "sub" from primary: server closed the connection unexpectedly
		This probably means the server terminated abnormally
		before or while processing the request.
2023-10-02 10:21:36.048 UTC [1013] FATAL:  could not connect to the primary server: connection to server on socket "/tmp/.s.PGSQL.5431" failed: No such file or directory
		Is the server running locally and accepting connections on that socket?
2023-10-02 10:21:36.048 UTC [956] LOG:  waiting for WAL to become available at 0/30003D8
2023-10-02 10:21:36.048 UTC [953] LOG:  background worker "slot-sync worker" (PID 999) exited with exit code 1
2023-10-02 10:21:36.048 UTC [958] ERROR:  could not receive list of slots from the primary server: server closed the connection unexpectedly
		This probably means the server terminated abnormally
		before or while processing the request.
2023-10-02 10:21:36.050 UTC [953] LOG:  background worker "logical replication launcher" (PID 958) exited with exit code 1
2023-10-02 10:21:36.141 UTC [956] LOG:  received promote request
2023-10-02 10:21:36.141 UTC [956] LOG:  redo done at 0/3000388 system usage: CPU: user: 0.00 s, system: 0.00 s, elapsed: 16.91 s
2023-10-02 10:21:36.141 UTC [956] LOG:  last completed transaction was at log time 2023-10-02 10:21:26.033498+00
2023-10-02 10:21:36.144 UTC [956] LOG:  selected new timeline ID: 2
2023-10-02 10:21:36.191 UTC [956] LOG:  archive recovery complete
2023-10-02 10:21:36.196 UTC [954] LOG:  checkpoint starting: force
2023-10-02 10:21:36.198 UTC [953] LOG:  database system is ready to accept connections
2023-10-02 10:21:36.410 UTC [954] LOG:  checkpoint complete: wrote 5 buffers (0.0%); 0 WAL file(s) added, 0 removed, 1 recycled; write=0.203 s, sync=0.005 s, total=0.215 s; sync files=4, longest=0.002 s, average=0.002 s; distance=16384 kB, estimate=16384 kB; lsn=0/3000460, redo lsn=0/30003F0
2023-10-02 10:21:36.473 UTC [1028] LOG:  duration: 3.179 ms  statement: INSERT INTO tbl VALUES (generate_series(21, 30))
2023-10-02 10:21:36.526 UTC [1034] LOG:  duration: 1.101 ms  statement: SELECT pg_catalog.set_config('search_path', '', false);
2023-10-02 10:21:36.526 UTC [1034] LOG:  received replication command: IDENTIFY_SYSTEM
2023-10-02 10:21:36.526 UTC [1034] STATEMENT:  IDENTIFY_SYSTEM
2023-10-02 10:21:36.526 UTC [1034] LOG:  received replication command: START_REPLICATION SLOT "sub" LOGICAL 0/0 (proto_version '4', origin 'any', publication_names '"pub"')
2023-10-02 10:21:36.526 UTC [1034] STATEMENT:  START_REPLICATION SLOT "sub" LOGICAL 0/0 (proto_version '4', origin 'any', publication_names '"pub"')
2023-10-02 10:21:36.526 UTC [1034] ERROR:  replication slot "sub" does not exist
2023-10-02 10:21:36.526 UTC [1034] STATEMENT:  START_REPLICATION SLOT "sub" LOGICAL 0/0 (proto_version '4', origin 'any', publication_names '"pub"')
2023-10-02 10:21:41.529 UTC [1039] LOG:  duration: 1.072 ms  statement: SELECT pg_catalog.set_config('search_path', '', false);
2023-10-02 10:21:41.530 UTC [1039] LOG:  received replication command: IDENTIFY_SYSTEM
2023-10-02 10:21:41.530 UTC [1039] STATEMENT:  IDENTIFY_SYSTEM
2023-10-02 10:21:41.530 UTC [1039] LOG:  received replication command: START_REPLICATION SLOT "sub" LOGICAL 0/0 (proto_version '4', origin 'any', publication_names '"pub"')
2023-10-02 10:21:41.530 UTC [1039] STATEMENT:  START_REPLICATION SLOT "sub" LOGICAL 0/0 (proto_version '4', origin 'any', publication_names '"pub"')
2023-10-02 10:21:41.530 UTC [1039] ERROR:  replication slot "sub" does not exist
2023-10-02 10:21:41.530 UTC [1039] STATEMENT:  START_REPLICATION SLOT "sub" LOGICAL 0/0 (proto_version '4', origin 'any', publication_names '"pub"')
2023-10-02 10:21:44.882 UTC [953] LOG:  received fast shutdown request
2023-10-02 10:21:44.884 UTC [953] LOG:  aborting any active transactions
2023-10-02 10:21:44.888 UTC [953] LOG:  background worker "logical replication launcher" (PID 1037) exited with exit code 1
2023-10-02 10:21:44.888 UTC [954] LOG:  shutting down
2023-10-02 10:21:44.891 UTC [954] LOG:  checkpoint starting: shutdown immediate
2023-10-02 10:21:44.900 UTC [954] LOG:  checkpoint complete: wrote 3 buffers (0.0%); 0 WAL file(s) added, 0 removed, 0 recycled; write=0.001 s, sync=0.003 s, total=0.013 s; sync files=3, longest=0.002 s, average=0.001 s; distance=1 kB, estimate=14746 kB; lsn=0/3000B60, redo lsn=0/3000B60
2023-10-02 10:21:44.906 UTC [953] LOG:  database system is shut down