Hi,
I received an alert dikkop (my rpi4 buildfarm animal running freebsd 14)
did not report any results for a couple days, and it seems it got into
an infinite loop in REL_11_STABLE when building hash table in a parallel
hashjoin, or something like that.
It seems to be progressing now, probably because I attached gdb to the
workers to get backtraces, which does signals etc.
Anyway, in 'ps ax' I saw this:
94545 - Ss 0:03.39 postgres: buildfarm regression [local] SELECT
94627 - Is 0:00.03 postgres: parallel worker for PID 94545
94628 - Is 0:00.02 postgres: parallel worker for PID 94545
and the backend was stuck waiting on this query:
select final > 1 as multibatch
from hash_join_batches(
$$
select count(*) from join_foo
left join (select b1.id, b1.t from join_bar b1 join join_bar
b2 using (id)) ss
on join_foo.id < ss.id + 1 and join_foo.id > ss.id - 1;
$$);
This started on 2023-01-20 23:23:18.125, and the next log (after I did
the gdb stuff), is from 2023-01-26 20:05:16.751. Quite a bit of time.
It seems all three processes are doing WaitEventSetWait, either through
a ConditionVariable, or WaitLatch. But I don't have any good idea of
what might have broken - and as it got "unstuck" I can't investigate
more. But I see there's nodeHash and parallelism, and I recall there's a
lot of gotchas due to how the backends cooperate when building the hash
table, etc. Thomas, any idea what might be wrong?
regards
--
Tomas Vondra
EnterpriseDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company
[Switching to LWP 100877 of process 94628]
_poll () at _poll.S:4
#0 _poll () at _poll.S:4
No locals.
#1 0x0000000088ef6850 in __thr_poll (fds=0x4, nfds=2, timeout=-1) at
/usr/src/lib/libthr/thread/thr_syscalls.c:338
curthread = 0x8f09b000
ret = <optimized out>
#2 0x00000000007d3318 in WaitEventSetWaitBlock (set=0x8f19ceb0,
cur_timeout=-1, occurred_events=0x80dcba98, nevents=1) at latch.c:1171
returned_events = 0
rc = <optimized out>
cur_pollfd = <optimized out>
cur_event = <optimized out>
errflags = <optimized out>
#3 WaitEventSetWait (set=0x8f19ceb0, timeout=<optimized out>,
occurred_events=<optimized out>, occurred_events@entry=0x80dcba98,
nevents=nevents@entry=1, wait_event_info=<optimized out>,
wait_event_info@entry=134217745) at latch.c:1000
rc = <optimized out>
start_time = {tv_sec = 32, tv_nsec = 2401711808}
cur_time = {tv_sec = 2161949248, tv_nsec = 9648676}
cur_timeout = -1
returned_events = <optimized out>
#4 0x00000000007f2898 in ConditionVariableSleep (cv=cv@entry=0x9c14f350,
wait_event_info=wait_event_info@entry=134217745) at condition_variable.c:157
event = {pos = -1676348592, events = 0, fd = -2133017936, user_data =
0x7d3128 <AddWaitEventToSet+220>}
done = <optimized out>
#5 0x00000000007cfd60 in BarrierArriveAndWait (barrier=0x9c14f338,
barrier@entry=0x80dcbbc0, wait_event_info=134217745, wait_event_info@entry=1)
at barrier.c:191
release = <optimized out>
start_phase = 5
next_phase = 6
elected = <optimized out>
#6 0x00000000006b4808 in ExecParallelHashIncreaseNumBuckets
(hashtable=hashtable@entry=0x8f0e16f0) at nodeHash.c:1572
pstate = <optimized out>
i = <optimized out>
chunk = <optimized out>
chunk_s = <optimized out>
#7 0x00000000006b2d30 in ExecParallelHashTupleAlloc
(hashtable=hashtable@entry=0x8f0e16f0, size=40, shared=shared@entry=0x80dcbbc0)
at nodeHash.c:2795
growth = PHJ_GROWTH_NEED_MORE_BUCKETS
chunk = <optimized out>
pstate = 0x9c14f2a0
chunk_size = <optimized out>
chunk_shared = <optimized out>
result = <optimized out>
curbatch = <optimized out>
#8 0x00000000006b27ac in ExecParallelHashTableInsert
(hashtable=hashtable@entry=0x8f0e16f0, slot=<optimized out>,
slot@entry=0x8f0e19d8, hashvalue=<optimized out>, hashvalue@entry=3919329229)
at nodeHash.c:1693
hashTuple = <optimized out>
tuple = 0x8f0ebd78
batchno = <optimized out>
shared = 2400066360
bucketno = <optimized out>
#9 0x00000000006b0ac8 in MultiExecParallelHash (node=0x8f0e0908) at
nodeHash.c:288
outerNode = 0x8f0e1170
hashtable = 0x8f0e16f0
hashkeys = 0x8f0ebac8
econtext = 0x8f0e1508
pstate = <optimized out>
build_barrier = <optimized out>
slot = 0x8f0e19d8
i = <optimized out>
hashvalue = <optimized out>
#10 MultiExecHash (node=node@entry=0x8f0e0b70) at nodeHash.c:112
No locals.
#11 0x00000000006a13e4 in MultiExecProcNode (node=node@entry=0x8f0e0908) at
execProcnode.c:502
result = <optimized out>
#12 0x00000000006b5b00 in ExecHashJoinImpl (pstate=0x8f0e0b70, parallel=true)
at nodeHashjoin.c:290
hashNode = <optimized out>
econtext = 0x8f0e07d8
joinqual = 0x0
otherqual = 0x0
outerNode = 0x8f0e0a58
hashtable = 0x8f0e16f0
node = 0x8f0e0b70
parallel_state = 0x9c14f2a0
hashvalue = <optimized out>
outerTupleSlot = <optimized out>
batchno = <optimized out>
build_barrier = <optimized out>
#13 ExecParallelHashJoin (pstate=0x8f0e0b70) at nodeHashjoin.c:600
No locals.
#14 0x00000000006a193c in ExecProcNodeInstr (node=0x8f0e0b70) at
execProcnode.c:462
result = <optimized out>
#15 0x000000000069a60c in ExecProcNode (node=0x8f0e0b70) at
../../../src/include/executor/executor.h:248
No locals.
#16 ExecutePlan (estate=0x8f0e0118, use_parallel_mode=<optimized out>,
operation=CMD_SELECT, numberTuples=0, direction=<optimized out>,
dest=0x8f1bca78, planstate=<optimized out>, sendTuples=<optimized out>,
execute_once=<optimized out>) at execMain.c:1712
current_tuple_count = 0
slot = <optimized out>
#17 standard_ExecutorRun (queryDesc=0x8f1bdf48, direction=<optimized out>,
count=0, execute_once=<optimized out>) at execMain.c:353
estate = 0x8f0e0118
oldcontext = 0x8f1bc000
operation = CMD_SELECT
dest = 0x8f1bca78
sendTuples = <optimized out>
#18 0x000000000069eafc in ParallelQueryMain (seg=seg@entry=0x8f0b1fb8,
toc=toc@entry=0x9c14f000) at execParallel.c:1402
pwcxt = {seg = 0x8f0b1fb8, toc = 0x9c14f000}
instrument_options = <optimized out>
fpes = 0x9c173240
receiver = <optimized out>
instrumentation = 0x9c1513a0
jit_instrumentation = 0x0
queryDesc = 0x8f1bdf48
area_space = <optimized out>
area = 0x8f2736c0
buffer_usage = <optimized out>
#19 0x0000000000581480 in ParallelWorkerMain (main_arg=<optimized out>) at
parallel.c:1433
msgbuf = {data = 0x0, len = 8, maxlen = 1024, cursor = 75}
seg = 0x8f0b1fb8
toc = 0x9c14f000
fps = 0x9c17bdc0
error_queue_space = <optimized out>
mq = <optimized out>
mqh = <optimized out>
library_name = <optimized out>
entrypointstate = <optimized out>
function_name = <optimized out>
entrypt = 0x69e8a4 <ParallelQueryMain>
libraryspace = <optimized out>
gucspace = <optimized out>
tstatespace = <optimized out>
combocidspace = <optimized out>
session_dsm_handle_space = <optimized out>
asnapspace = <optimized out>
tsnapspace = 0x0
asnapshot = 0x8f1bc530
tsnapshot = <optimized out>
reindexspace = <optimized out>
#20 0x000000000076bc0c in StartBackgroundWorker () at bgworker.c:911
local_sigjmp_buf = {{_sjb = {39880947222706195019826460417,
39880947204593520499195791704, 44268792018715219089931894785,
44284777967129495787362320385, 183681166717697722631815792,
184965650401038266130728128, 143540313743542789695389968, 0, 0, 0, 0,
-2147815353, 44270270562146215057922977792, 44278461064088894690907619968,
43989261717364479129179652097, 43989270866949539691517728768,
-34707997198133280150621247941514362856, 41942739273203203019210801264,
43989270866949539689117253632, 44280950489095129942301282432,
104334784480903624415232, 177864391802423036901900480,
44284788592454082244074078208, 44270270562146215057922977792,
18446744076110234240, 9959648, 44269050125558298436377936088,
178361051939863592869609728, 44284788592454082244064051201, 9959648,
44269050125558298436377936088, 177869187955882201385320736}}}
worker = 0x8f0a4958
entrypt = 0xd1
#21 0x00000000007783fc in do_start_bgworker (rw=0x8f178280) at postmaster.c:5824
worker_pid = <optimized out>
#22 maybe_start_bgworkers () at postmaster.c:6049
rw = 0x8f178280
iter = {cur = 0x8f1784c0, next = 0x8f178240, prev = 0x8f178740}
num_launched = 1
now = <optimized out>
#23 0x0000000000776d68 in sigusr1_handler (postgres_signal_arg=<optimized out>)
at postmaster.c:5162
save_errno = 4
#24 0x0000000088ef437c in handle_signal (actp=actp@entry=0x80dcc630,
sig=sig@entry=30, info=info@entry=0x80dcc6a0, ucp=ucp@entry=0x80dcc6f0) at
/usr/src/lib/libthr/thread/thr_sig.c:303
uc2 = {uc_sigmask = {__bits = {0, 0, 0, 0}}, uc_mcontext = {mc_gpregs =
{gp_x = {4, 2161953552, 0, 0, 2161953824, 2297391804, 8432443308396441110,
3679990472132909591, 93, 0, 1674256998, 18, 1, 169, 218, 84, 2297537056,
2273493208, 36, 2161953824, 0, 0, 2161953552, 4, 2399776768, 1674256998,
10030544, 10027008, 4, 2161953456}, gp_lr = 2297391884, gp_sp = 2161953456,
gp_elr = 2273493216, gp_spsr = 536871424, gp_pad = 0}, mc_fpregs = {fp_q = {0,
0, 0, 0, 8, 0 <repeats 11 times>, 121434099567864314412419957946238851931,
20016609818878733144904388672456953615, 5353319624539885856935966443534025088,
4055468751613154266206821436120303488, 329104672824602439286622223271128883200,
299145699252825572497233386413785672704,
79711101982042594000931763776512992000,
220482984679275540990975009131135516160, 9641520097728932941005833317657102080,
127421113153814117449301097585084629760, 5100529580561016829347444552778175744,
289206502006071331255019155771212188160,
111019628692199554885892317278934521344,
272984873768906578505639117416367422440,
99596431717910932209290763223621543680,
185721312638819399367146379301298123520}, fp_sr = 16, fp_cr = 0, fp_flags = 1,
fp_pad = 0}, mc_flags = 1, mc_pad = 0, mc_spare = {0, 0, 0, 0, 0, 0, 0, 0}},
uc_link = 0x0, uc_stack = {ss_sp = 0x0, ss_size = 0, ss_flags = 4}, uc_flags =
0, __spare__ = {0, 0, 0, 0}}
curthread = 0x8f09b000
in_sigsuspend = 0
cancel_point = 1
cancel_async = <optimized out>
cancel_enable = 1
sigfunc = 0x8000011
err = <optimized out>
#25 0x0000000088ef3ab8 in thr_sighandler (sig=30, info=0x80dcc6a0,
_ucp=0x80dcc6f0) at /usr/src/lib/libthr/thread/thr_sig.c:246
act = {__sigaction_u = {__sa_handler = 0x776bb4 <sigusr1_handler>,
__sa_sigaction = 0x776bb4 <sigusr1_handler>}, sa_flags = 0, sa_mask = {__bits =
{2147217735, 4294967295, 4294967295, 4294967295}}}
err = 4
usa = 0x88f1b9c8
curthread = 0x8f09b000
ucp = <optimized out>
#26 <signal handler called>
No symbol table info available.
#27 _select () at _select.S:4
No locals.
#28 0x0000000088ef6b0c in __thr_select (numfds=4, readfds=0x80dccb10,
writefds=0x0, exceptfds=0x0, timeout=0x80dccc20) at
/usr/src/lib/libthr/thread/thr_syscalls.c:495
curthread = 0x8f09b000
ret = <optimized out>
#29 0x0000000000778930 in ServerLoop () at postmaster.c:1692
timeout = {tv_sec = 60, tv_usec = 0}
rmask = {__fds_bits = {8, 0 <repeats 15 times>}}
selres = <optimized out>
now = <optimized out>
readmask = {__fds_bits = {8, 0 <repeats 15 times>}}
last_lockfile_recheck_time = 1674256970
last_touch_time = 1674256850
nSockets = 4
#30 0x0000000000776444 in PostmasterMain (argc=<optimized out>, argc@entry=3,
argv=<optimized out>, argv@entry=0x80dcd580) at postmaster.c:1401
output_config_variable = <optimized out>
listen_addr_saved = <optimized out>
userDoption = <optimized out>
opt = <optimized out>
i = <optimized out>
status = <optimized out>
#31 0x00000000006e57c4 in main (argc=3, argv=0x80dcd580) at main.c:228
do_check_root = <optimized out>
A debugging session is active.
Inferior 1 [process 94628] will be detached.
Quit anyway? (y or n) [answered Y; input not from terminal]
[Inferior 1 (process 94628) detached]
[Switching to LWP 100610 of process 94627]
_poll () at _poll.S:4
#0 _poll () at _poll.S:4
No locals.
#1 0x0000000088ef6850 in __thr_poll (fds=0x4, nfds=2, timeout=-1) at
/usr/src/lib/libthr/thread/thr_syscalls.c:338
curthread = 0x8f09b000
ret = <optimized out>
#2 0x00000000007d3318 in WaitEventSetWaitBlock (set=0x8f19ceb0,
cur_timeout=-1, occurred_events=0x80dcbb68, nevents=1) at latch.c:1171
returned_events = 0
rc = <optimized out>
cur_pollfd = <optimized out>
cur_event = <optimized out>
errflags = <optimized out>
#3 WaitEventSetWait (set=0x8f19ceb0, timeout=<optimized out>,
occurred_events=<optimized out>, occurred_events@entry=0x80dcbb68,
nevents=nevents@entry=1, wait_event_info=<optimized out>,
wait_event_info@entry=134217737) at latch.c:1000
rc = <optimized out>
start_time = {tv_sec = 2400107896, tv_nsec = 1}
cur_time = {tv_sec = 2446491840, tv_nsec = 10170712}
cur_timeout = -1
returned_events = <optimized out>
#4 0x00000000007f2898 in ConditionVariableSleep (cv=cv@entry=0x9bd4f308,
wait_event_info=wait_event_info@entry=134217737) at condition_variable.c:157
event = {pos = 0, events = 0, fd = 7084820, user_data = 0x0}
done = <optimized out>
#5 0x00000000007cfd60 in BarrierArriveAndWait
(barrier=barrier@entry=0x9bd4f2f0, wait_event_info=134217737) at barrier.c:191
release = <optimized out>
start_phase = 2
next_phase = 3
elected = <optimized out>
#6 0x00000000006b0c00 in MultiExecParallelHash (node=0x8f0e0908) at
nodeHash.c:312
outerNode = 0x8f0e1170
hashtable = 0x8f0e16f0
hashkeys = 0x8f0ebac8
econtext = 0x8f0e1508
pstate = <optimized out>
build_barrier = <optimized out>
slot = <optimized out>
i = <optimized out>
hashvalue = <optimized out>
#7 MultiExecHash (node=node@entry=0x8f0e0b70) at nodeHash.c:112
No locals.
#8 0x00000000006a13e4 in MultiExecProcNode (node=node@entry=0x8f0e0908) at
execProcnode.c:502
result = <optimized out>
#9 0x00000000006b5b00 in ExecHashJoinImpl (pstate=0x8f0e0b70, parallel=true)
at nodeHashjoin.c:290
hashNode = <optimized out>
econtext = 0x8f0e07d8
joinqual = 0x0
otherqual = 0x0
outerNode = 0x8f0e0a58
hashtable = 0x8f0e16f0
node = 0x8f0e0b70
parallel_state = 0x9bd4f2a0
hashvalue = <optimized out>
outerTupleSlot = <optimized out>
batchno = <optimized out>
build_barrier = <optimized out>
#10 ExecParallelHashJoin (pstate=0x8f0e0b70) at nodeHashjoin.c:600
No locals.
#11 0x00000000006a193c in ExecProcNodeInstr (node=0x8f0e0b70) at
execProcnode.c:462
result = <optimized out>
#12 0x000000000069a60c in ExecProcNode (node=0x8f0e0b70) at
../../../src/include/executor/executor.h:248
No locals.
#13 ExecutePlan (estate=0x8f0e0118, use_parallel_mode=<optimized out>,
operation=CMD_SELECT, numberTuples=0, direction=<optimized out>,
dest=0x8f1bca78, planstate=<optimized out>, sendTuples=<optimized out>,
execute_once=<optimized out>) at execMain.c:1712
current_tuple_count = 0
slot = <optimized out>
#14 standard_ExecutorRun (queryDesc=0x8f1bdf48, direction=<optimized out>,
count=0, execute_once=<optimized out>) at execMain.c:353
estate = 0x8f0e0118
oldcontext = 0x8f1bc000
operation = CMD_SELECT
dest = 0x8f1bca78
sendTuples = <optimized out>
#15 0x000000000069eafc in ParallelQueryMain (seg=seg@entry=0x8f0b1fb8,
toc=toc@entry=0x9bd4f000) at execParallel.c:1402
pwcxt = {seg = 0x8f0b1fb8, toc = 0x9bd4f000}
instrument_options = <optimized out>
fpes = 0x9bd73240
receiver = <optimized out>
instrumentation = 0x9bd513a0
jit_instrumentation = 0x0
queryDesc = 0x8f1bdf48
area_space = <optimized out>
area = 0x8f2736c0
buffer_usage = <optimized out>
#16 0x0000000000581480 in ParallelWorkerMain (main_arg=<optimized out>) at
parallel.c:1433
msgbuf = {data = 0x0, len = 8, maxlen = 1024, cursor = 75}
seg = 0x8f0b1fb8
toc = 0x9bd4f000
fps = 0x9bd7bdc0
error_queue_space = <optimized out>
mq = <optimized out>
mqh = <optimized out>
library_name = <optimized out>
entrypointstate = <optimized out>
function_name = <optimized out>
entrypt = 0x69e8a4 <ParallelQueryMain>
libraryspace = <optimized out>
gucspace = <optimized out>
tstatespace = <optimized out>
combocidspace = <optimized out>
session_dsm_handle_space = <optimized out>
asnapspace = <optimized out>
tsnapspace = 0x0
asnapshot = 0x8f1bc530
tsnapshot = <optimized out>
reindexspace = <optimized out>
#17 0x000000000076bc0c in StartBackgroundWorker () at bgworker.c:911
local_sigjmp_buf = {{_sjb = {39880947222706195019826460417,
39880947204593520499195791704, 44268792018715219089931894785,
44284789773045702961475354624, 183681166717697722631815696,
184965650401038266130728768, 143540313743542789695389968, 0, 0, 0, 0,
-2147815353, 44270268791258783981806022656, 44278461064088894690907620608,
43989261717364479129179652097, 43989270866949539691517728768,
-34707997198133280150621247941514362856, 41942739273203203019210801264,
43989270866949539689117253632, 44280950489095129942301282432,
104334784480903624415232, 177864391802423036901900480,
44284800398370289418187112448, 44270268791258783981806022656, 2400683264,
9959648, 44269050125558298436377936088, 178361051939863592869609728,
44284800398370289418177085440, 9959648, 44269050125558298436377936088,
177869187955882201385320736}}}
worker = 0x8f0a4958
entrypt = 0xd1
#18 0x00000000007783fc in do_start_bgworker (rw=0x8f178500) at postmaster.c:5824
worker_pid = <optimized out>
#19 maybe_start_bgworkers () at postmaster.c:6049
rw = 0x8f178500
iter = {cur = 0x8f178740, next = 0x8f1784c0, prev = 0x9905d8
<BackgroundWorkerList>}
num_launched = 0
now = <optimized out>
#20 0x0000000000776d68 in sigusr1_handler (postgres_signal_arg=<optimized out>)
at postmaster.c:5162
save_errno = 4
#21 0x0000000088ef437c in handle_signal (actp=actp@entry=0x80dcc630,
sig=sig@entry=30, info=info@entry=0x80dcc6a0, ucp=ucp@entry=0x80dcc6f0) at
/usr/src/lib/libthr/thread/thr_sig.c:303
uc2 = {uc_sigmask = {__bits = {0, 0, 0, 0}}, uc_mcontext = {mc_gpregs =
{gp_x = {4, 2161953552, 0, 0, 2161953824, 2297391804, 8432443308396441110,
3679990472132909591, 93, 0, 1674256998, 18, 1, 169, 218, 84, 2297537056,
2273493208, 36, 2161953824, 0, 0, 2161953552, 4, 2399776768, 1674256998,
10030544, 10027008, 4, 2161953456}, gp_lr = 2297391884, gp_sp = 2161953456,
gp_elr = 2273493216, gp_spsr = 536871424, gp_pad = 0}, mc_fpregs = {fp_q = {0,
0, 0, 0, 8, 0 <repeats 11 times>, 121434099567864314412419957946238851931,
20016609818878733144904388672456953615, 5353319624539885856935966443534025088,
4055468751613154266206821436120303488, 329104672824602439286622223271128883200,
299145699252825572497233386413785672704,
79711101982042594000931763776512992000,
220482984679275540990975009131135516160, 9641520097728932941005833317657102080,
127421113153814117449301097585084629760, 5100529580561016829347444552778175744,
289206502006071331255019155771212188160,
111019628692199554885892317278934521344,
272984873768906578505639117416367422440,
99596431717910932209290763223621543680,
185721312638819399367146379301298123520}, fp_sr = 16, fp_cr = 0, fp_flags = 1,
fp_pad = 0}, mc_flags = 1, mc_pad = 0, mc_spare = {0, 0, 0, 0, 0, 0, 0, 0}},
uc_link = 0x0, uc_stack = {ss_sp = 0x0, ss_size = 0, ss_flags = 4}, uc_flags =
0, __spare__ = {0, 0, 0, 0}}
curthread = 0x8f09b000
in_sigsuspend = 0
cancel_point = 1
cancel_async = <optimized out>
cancel_enable = 1
sigfunc = 0x8000009
err = <optimized out>
#22 0x0000000088ef3ab8 in thr_sighandler (sig=30, info=0x80dcc6a0,
_ucp=0x80dcc6f0) at /usr/src/lib/libthr/thread/thr_sig.c:246
act = {__sigaction_u = {__sa_handler = 0x776bb4 <sigusr1_handler>,
__sa_sigaction = 0x776bb4 <sigusr1_handler>}, sa_flags = 0, sa_mask = {__bits =
{2147217735, 4294967295, 4294967295, 4294967295}}}
err = 4
usa = 0x88f1b9c8
curthread = 0x8f09b000
ucp = <optimized out>
#23 <signal handler called>
No symbol table info available.
#24 _select () at _select.S:4
No locals.
#25 0x0000000088ef6b0c in __thr_select (numfds=4, readfds=0x80dccb10,
writefds=0x0, exceptfds=0x0, timeout=0x80dccc20) at
/usr/src/lib/libthr/thread/thr_syscalls.c:495
curthread = 0x8f09b000
ret = <optimized out>
#26 0x0000000000778930 in ServerLoop () at postmaster.c:1692
timeout = {tv_sec = 60, tv_usec = 0}
rmask = {__fds_bits = {8, 0 <repeats 15 times>}}
selres = <optimized out>
now = <optimized out>
readmask = {__fds_bits = {8, 0 <repeats 15 times>}}
last_lockfile_recheck_time = 1674256970
last_touch_time = 1674256850
nSockets = 4
#27 0x0000000000776444 in PostmasterMain (argc=<optimized out>, argc@entry=3,
argv=<optimized out>, argv@entry=0x80dcd580) at postmaster.c:1401
output_config_variable = <optimized out>
listen_addr_saved = <optimized out>
userDoption = <optimized out>
opt = <optimized out>
i = <optimized out>
status = <optimized out>
#28 0x00000000006e57c4 in main (argc=3, argv=0x80dcd580) at main.c:228
do_check_root = <optimized out>
A debugging session is active.
Inferior 1 [process 94627] will be detached.
Quit anyway? (y or n) [answered Y; input not from terminal]
[Inferior 1 (process 94627) detached]
[Switching to LWP 100397 of process 94545]
_poll () at _poll.S:4
#0 _poll () at _poll.S:4
No locals.
#1 0x0000000088ef6850 in __thr_poll (fds=0x4, nfds=1, timeout=-1) at
/usr/src/lib/libthr/thread/thr_syscalls.c:338
curthread = 0x8f09b000
ret = <optimized out>
#2 0x00000000007d3318 in WaitEventSetWaitBlock (set=0x9c1c7a60,
cur_timeout=-1, occurred_events=0x80dcac48, nevents=1) at latch.c:1171
returned_events = 0
rc = <optimized out>
cur_pollfd = <optimized out>
cur_event = <optimized out>
errflags = <optimized out>
#3 WaitEventSetWait (set=set@entry=0x9c1c7a60, timeout=<optimized out>,
timeout@entry=-1, occurred_events=<optimized out>,
occurred_events@entry=0x80dcac48, nevents=nevents@entry=1,
wait_event_info=<optimized out>, wait_event_info@entry=134217731) at
latch.c:1000
rc = <optimized out>
start_time = {tv_sec = 24, tv_nsec = 65001}
cur_time = {tv_sec = 2161945616, tv_nsec = 8235108}
cur_timeout = -1
returned_events = <optimized out>
#4 0x00000000007d2f88 in WaitLatchOrSocket (latch=0x9a2dc658,
wakeEvents=wakeEvents@entry=1, sock=-1, timeout=-1, wait_event_info=134217731)
at latch.c:385
event = {pos = 0, events = 0, fd = -1666879800, user_data = 0x0}
ret = 0
set = 0x9c1c7a60
rc = <optimized out>
#5 0x00000000007d2e74 in WaitLatch (latch=0x4, wakeEvents=wakeEvents@entry=1,
timeout=2297391124, wait_event_info=134217731) at latch.c:339
No locals.
#6 0x00000000006b067c in gather_readnext (gatherstate=<optimized out>) at
nodeGather.c:367
readerdone = <optimized out>
reader = <optimized out>
tup = <optimized out>
nvisited = 2
readerdone = <optimized out>
reader = <optimized out>
tup = <optimized out>
#7 gather_getnext (gatherstate=0x9c1280b0) at nodeGather.c:256
outerPlan = 0x9c128288
fslot = 0x9ca56ec8
outerTupleSlot = <optimized out>
tup = <optimized out>
estate = <optimized out>
#8 ExecGather (pstate=0x9c1280b0) at nodeGather.c:207
node = 0x9c1280b0
econtext = 0x9c1281c8
slot = <optimized out>
#9 0x00000000006a193c in ExecProcNodeInstr (node=0x9c1280b0) at
execProcnode.c:462
result = <optimized out>
#10 0x00000000006bfd78 in ExecProcNode (node=0x9c1280b0) at
../../../src/include/executor/executor.h:248
No locals.
#11 ExecNestLoop (pstate=0x9c127818) at nodeNestloop.c:160
node = 0x9c127818
joinqual = 0x9ca57748
econtext = 0x9c127930
nl = 0x9c142a50
innerPlan = 0x9c1280b0
otherqual = 0x0
outerPlan = 0x9c1279f0
outerTupleSlot = <optimized out>
lc = <optimized out>
innerTupleSlot = <optimized out>
#12 0x00000000006a193c in ExecProcNodeInstr (node=0x9c127818) at
execProcnode.c:462
result = <optimized out>
#13 0x00000000006ac818 in ExecProcNode (node=0x9c127818) at
../../../src/include/executor/executor.h:248
No locals.
#14 fetch_input_tuple (aggstate=aggstate@entry=0x9c127368) at nodeAgg.c:407
slot = <optimized out>
#15 0x00000000006aba70 in agg_retrieve_direct (aggstate=0x9c127368) at
nodeAgg.c:1843
node = 0x9c142bc0
numGroupingSets = <optimized out>
econtext = <optimized out>
tmpcontext = 0x9c1275a0
peragg = <optimized out>
pergroups = 0x9c1c26d8
firstSlot = 0x9ca590c0
i = <optimized out>
numReset = <optimized out>
nextSetSize = <optimized out>
outerslot = <optimized out>
currentSet = <optimized out>
result = <optimized out>
hasGroupingSets = <optimized out>
#16 ExecAgg (pstate=0x9c127368) at nodeAgg.c:1561
node = 0x9c127368
result = 0x0
#17 0x00000000006a193c in ExecProcNodeInstr (node=0x9c127368) at
execProcnode.c:462
result = <optimized out>
#18 0x000000000069a60c in ExecProcNode (node=0x9c127368) at
../../../src/include/executor/executor.h:248
No locals.
#19 ExecutePlan (estate=0x9c127118, use_parallel_mode=<optimized out>,
operation=CMD_SELECT, numberTuples=0, direction=<optimized out>, dest=0x97fb18
<donothingDR>, planstate=<optimized out>, sendTuples=<optimized out>,
execute_once=<optimized out>) at execMain.c:1712
current_tuple_count = 0
slot = <optimized out>
#20 standard_ExecutorRun (queryDesc=0x8f163540, direction=<optimized out>,
count=0, execute_once=<optimized out>) at execMain.c:353
estate = 0x9c127118
oldcontext = 0x8f22a800
operation = CMD_SELECT
dest = 0x97fb18 <donothingDR>
sendTuples = <optimized out>
#21 0x00000000006347ac in ExplainOnePlan
(plannedstmt=plannedstmt@entry=0x8f163428, into=into@entry=0x0,
es=es@entry=0x8f128130, queryString=queryString@entry=0x8f22a918 "explain
(analyze, format 'json') \n select count(*) from join_foo\n left join
(select b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss\n on
join_foo.id < ss.id + 1 and join_foo.id > ss"..., params=params@entry=0x0,
queryEnv=queryEnv@entry=0x0, planduration=planduration@entry=0x80dcaff0) at
explain.c:536
dir = ForwardScanDirection
starttime = {tv_sec = 395092, tv_nsec = 68500214}
instrument_option = 1
totaltime = 0
dest = 0x97fb18 <donothingDR>
queryDesc = 0x8f163540
eflags = <optimized out>
#22 0x00000000006341bc in ExplainOneQuery (query=<optimized out>,
cursorOptions=256, into=0x0, es=0x8f128130, queryString=0x8f22a918 "explain
(analyze, format 'json') \n select count(*) from join_foo\n left join
(select b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss\n on
join_foo.id < ss.id + 1 and join_foo.id > ss"..., params=0x0, queryEnv=0x0) at
explain.c:372
planstart = {tv_sec = 395092, tv_nsec = 68233291}
planduration = {tv_sec = 0, tv_nsec = 266330}
plan = 0x8f163428
#23 0x0000000000633cb4 in ExplainQuery (pstate=<optimized out>,
pstate@entry=0x8f128018, stmt=stmt@entry=0x8f22aba8,
queryString=queryString@entry=0x8f22a918 "explain (analyze, format 'json') \n
select count(*) from join_foo\n left join (select b1.id, b1.t from join_bar
b1 join join_bar b2 using (id)) ss\n on join_foo.id < ss.id + 1 and
join_foo.id > ss"..., params=params@entry=0x0, queryEnv=queryEnv@entry=0x0,
dest=dest@entry=0x8f127f80) at explain.c:255
l = 0x8f13dea0
es = 0x8f128130
summary_set = <optimized out>
timing_set = <optimized out>
lc = <optimized out>
rewritten = <optimized out>
tstate = <optimized out>
#24 0x0000000000800244 in standard_ProcessUtility (pstmt=0x8f22aa90,
queryString=0x8f22a918 "explain (analyze, format 'json') \n select count(*)
from join_foo\n left join (select b1.id, b1.t from join_bar b1 join join_bar
b2 using (id)) ss\n on join_foo.id < ss.id + 1 and join_foo.id > ss"...,
context=PROCESS_UTILITY_QUERY, params=0x0, queryEnv=0x0, dest=0x8f127f80,
completionTag=0x80dcb1a0 "") at utility.c:675
parsetree = 0x8f22aba8
isAtomicContext = true
pstate = 0x8f128018
isTopLevel = <optimized out>
#25 0x00000000007ff924 in PortalRunUtility (portal=portal@entry=0x8f1bb230,
pstmt=0x8f22aa90, isTopLevel=false, setHoldSnapshot=true,
dest=dest@entry=0x8f127f80, completionTag=completionTag@entry=0x80dcb1a0 "") at
pquery.c:1174
No locals.
#26 0x00000000007fec5c in FillPortalStore (portal=portal@entry=0x8f1bb230,
isTopLevel=false) at pquery.c:1047
completionTag =
"\000\263܀\000\000\000\000P\272܀\000\000\000\000\000\220\235\000\000\000\000\000\000@\233\000\000\000\000\000p\263܀\000\000\000\000\374\343\177",
'\000' <repeats 20 times>
treceiver = 0x8f127f80
#27 0x00000000007ff2d8 in PortalRunFetch (portal=portal@entry=0x8f1bb230,
fdirection=fdirection@entry=FETCH_FORWARD, count=count@entry=10,
dest=dest@entry=0x97fb98 <spi_printtupDR>) at pquery.c:1463
local_sigjmp_buf = {{_sjb = {39880885831941917714438682368,
39880924773352726868382167600, 10, 39880918575246718101733814816,
190330258725578183311320752, 183735916654108490191290368,
154678752963153796313953328, 0, 0, 0, 0, 43989270866949539691517689856,
-34707997198133280150621247941514362848, 41942739273203203019210797888,
43989270866949539689117253632, 44280232689389733756228800640, 2400436224,
-34707997198133280150621247945809330176, 177865941328925228504232816,
44289838868259606152884289752, 48275430291761179521354809344,
178356624721285902577218480, 178355148981760005813089368,
44289838868259606152668686896, 48275430291761179518964381272,
131622167545424227749114864, 0, 39880918575246718102190223640,
44271074249892018435664963944, 131637736597422438610678928,
184738976809860520770113536, 0}}}
save_exception_stack = 0x80dcba50
save_context_stack = 0x80dcb900
saveActivePortal = 0x8f1bb118
saveResourceOwner = 0x9c1366b0
savePortalContext = 0x8f0c4000
oldContext = 0x9bfc8000
result = <optimized out>
#28 0x00000000006ce4e8 in _SPI_cursor_operation (portal=0x8f1bb230,
portal@entry=0x1, direction=FETCH_FORWARD, direction@entry=FETCH_BACKWARD,
count=10, count@entry=2161948952, dest=0x97fb98 <spi_printtupDR>) at spi.c:2711
nfetched = <optimized out>
#29 0x00000000006ce46c in SPI_cursor_fetch (portal=0x4,
portal@entry=0x8f1bb230, forward=<optimized out>, count=4294967295) at
spi.c:1611
No locals.
#30 0x00000000a2b1cd38 in exec_for_query (estate=estate@entry=0x80dcb918,
stmt=stmt@entry=0x8f122820, portal=portal@entry=0x8f1bb230,
prefetch_ok=<optimized out>) at pl_exec.c:5979
tupdescs_match = true
previous_id = 1
rc = 0
found = false
var = 0x8f122878
n = <optimized out>
tuptab = <optimized out>
#31 0x00000000a2b19580 in exec_stmt_dynfors (estate=0x80dcb918,
stmt=0x8f122820) at pl_exec.c:4547
portal = 0x8f1bb230
rc = <optimized out>
#32 exec_stmt (estate=estate@entry=0x80dcb918, stmt=0x8f122820) at
pl_exec.c:2029
rc = -1
save_estmt = 0x8f1735a0
#33 0x00000000a2b15844 in exec_stmts (estate=0x80dcb918, stmts=<optimized out>)
at pl_exec.c:1912
stmt = 0x1
rc = <optimized out>
s = <optimized out>
#34 exec_stmt_block (estate=estate@entry=0x80dcb918, block=0x8f1735a0) at
pl_exec.c:1853
rc = -1
i = <optimized out>
#35 0x00000000a2b14358 in plpgsql_exec_function (func=func@entry=0x9c133980,
fcinfo=fcinfo@entry=0x80dcbd80, simple_eval_estate=<optimized out>,
atomic=<optimized out>) at pl_exec.c:597
estate = {func = 0x9c133980, trigdata = 0x0, evtrigdata = 0x0, retval =
0, retisnull = true, rettype = 0, fn_rettype = 2249, retistuple = true,
retisset = true, readonly_func = false, atomic = true, exitlabel = 0x0,
cur_error = 0x0, tuple_store = 0x0, tuple_store_desc = 0x0, tuple_store_cxt =
0x8f22b000, tuple_store_owner = 0x9c1366b0, rsi = 0x80dcbd10, found_varno = 4,
ndatums = 8, datums = 0x8f221170, datum_context = 0x8f221000, paramLI =
0x8f221118, simple_eval_estate = 0x9c0af118, cast_hash = 0x9bfcf118,
cast_hash_context = 0x8f27b000, stmt_mcontext = 0x9c10f000,
stmt_mcontext_parent = 0x8f221000, eval_tuptable = 0x0, eval_processed = 0,
eval_lastoid = 0, eval_econtext = 0x9c0af330, err_stmt = 0x8f122820, err_text =
0x0, plugin_info = 0x0}
plerrcontext = {previous = 0x0, callback = 0xa2b149b0
<plpgsql_exec_error_callback>, arg = 0x80dcb918}
i = <optimized out>
rc = <optimized out>
#36 0x00000000a2b0ffcc in plpgsql_call_handler (fcinfo=0x80dcbd80) at
pl_handler.c:263
local_sigjmp_buf = {{_sjb = {39880924791465401389011695360,
48302902658775273682146999680, 39880924773352726865981210624,
190341179198069816747360256, 190341031624117227070947328,
39880967864946883051493785600, 50350549173733425359515073632, 0, 0, 0, 0,
171769808921398285562592048, 44269124060108545861860982964,
44269124060108545861860982960, 175619201687723699955613456,
44269124060108545864260818840, 44269124060108545861860982809,
39880947794889330855501627394, 0, 44269124060109390286791114752,
41948354462099240206722710832, 53458707922886809687,
41937478942441387481939531863, 41937468300551581251932044688,
190330258725578180703121408, 39880945138558184243726144104,
18243829888353285701584, -34707997198133280150621247943647380160,
41943067846608643933744184784, 43989270866949539691518675624,
127179601276664609014332560, 190362060912361258121739648}}}
save_exception_stack = 0x80dcc370
save_context_stack = 0x0
nonatomic = false
rc = <optimized out>
func = 0x9c133980
save_cur_estate = 0x0
retval = <optimized out>
#37 0x00000000006a2fd4 in ExecMakeTableFunctionResult (setexpr=0x8f22b598,
econtext=0x8f22b448, argContext=<optimized out>, expectedDesc=0x8f22c5a0,
randomAccess=false) at execSRF.c:231
result = <optimized out>
fcinfo = {flinfo = 0x8f22b5b8, context = 0x0, resultinfo = 0x80dcbd10,
fncollation = 100, isnull = false, nargs = 1, arg = {2399836504, 2400316024,
2400317744, 2161950728, 2401048280, 16565219775467706455, 2161950288,
2273753640, 2401421992, 2, 2618185728, 16565219775467706455, 2161950288,
2273753680, 2401421992, 2161950432, 2384662656, 2161950376, 2161950320,
7237744, 0, 16565219775467706455, 2161950512, 2273715716, 2618185728, 147,
2161950512, 2273715752, 2400317288, 8192, 936, 8192, 2161950416, 2161950472,
2161950560, 6874480, 2161950832, 2401421992, 18446744067281567488, 4294967295,
4311744512, 0, 2272496949, 2272532888, 1, 2401421992, 8192, 0, 6, 2400510048,
2400510848, 98784247809, 0, 0, 0, 0, 2161950656, 6893288, 2401421992, 2,
2400510016, 2400510848, 2401423184, 2400510048, 0, 2400317248, 2161950832,
2401421992, 2161950896, 6875144, 2400321448, 2401779496, 2618185728,
2400317472, 2401421997, 2401422000, 2161950864, 2616705072, 2161950864,
9379024, 2616705008, 2616705072, 2401096016, 260099453208, 0, 0, 0, 1,
6456918176, 16, 16, 0, 0, 2616705072, 2161950896, 9690020, 2618517168,
2616705072, 2161950928, 9379360}, argnull = {false, 202, 34, 143, false, false,
false, false, 240, 191, 247, 155, false, false, false, false, 240, 192, 220,
128, false, false, false, false, 120, 119, 143, false, false, false, false,
false, 112, 193, 220, 128, false, false, false, false, 48, 192, 247, 155,
false, false, false, false, 112, 193, 220, 128, false, false, false, false,
208, 28, 143, false, false, false, false, false, 240, 191, 247, 155, false,
false, false, false, 48, 192, 247, 155, false, false, false, false, 80, 209,
29, 143, false, false, false, false, 184, 198, 34, 143, 60, false, false,
false, false, false, false, false}}
fcusage = {fs = 0x0, save_f_total_time = {tv_sec = 0, tv_nsec =
2384662656}, save_total = {tv_sec = 2161950096, tv_nsec = 7237244}, f_start =
{tv_sec = 2400317744, tv_nsec = 2161950728}}
rsinfo = {type = T_ReturnSetInfo, econtext = 0x8f22b448, expectedDesc =
0x8f22c5a0, allowedModes = 11, returnMode = SFRM_ValuePerCall, isDone =
ExprSingleResult, setResult = 0x0, setDesc = 0x0}
tmptup = {t_len = 2399823208, t_self = {ip_blkid = {bi_hi = 0, bi_lo =
0}, ip_posid = 25960}, t_tableOid = 0, t_data = 0x3c8}
first_time = <optimized out>
returnsSet = <optimized out>
tupdesc = 0x0
tupstore = 0x0
callerContext = 0x8f22b000
funcrettype = 2249
oldcontext = <optimized out>
returnsTuple = <optimized out>
#38 0x00000000006b00e8 in FunctionNext (node=0x8f22b330) at
nodeFunctionscan.c:95
tstore = 0x0
estate = <optimized out>
scanslot = 0x8f22c7d0
direction = ForwardScanDirection
oldpos = <optimized out>
funcno = <optimized out>
att = <optimized out>
alldone = <optimized out>
#39 0x00000000006a27b4 in ExecScan (node=0x8f22b330, accessMtd=0x6b008c
<FunctionNext>, recheckMtd=0x6b0320 <FunctionRecheck>) at execScan.c:162
slot = <optimized out>
econtext = 0x8f22b448
projInfo = 0x8f22caa0
qual = 0x0
#40 0x000000000069a60c in ExecProcNode (node=0x8f22b330) at
../../../src/include/executor/executor.h:248
No locals.
#41 ExecutePlan (estate=0x8f22b118, use_parallel_mode=<optimized out>,
operation=CMD_SELECT, numberTuples=0, direction=<optimized out>,
dest=0x9c0e5ac0, planstate=<optimized out>, sendTuples=<optimized out>,
execute_once=<optimized out>) at execMain.c:1712
current_tuple_count = 0
slot = <optimized out>
#42 standard_ExecutorRun (queryDesc=0x8f0c4118, direction=<optimized out>,
count=0, execute_once=<optimized out>) at execMain.c:353
estate = 0x8f22b118
oldcontext = 0x8f0c4000
operation = CMD_SELECT
dest = 0x9c0e5ac0
sendTuples = <optimized out>
#43 0x00000000007fedb8 in PortalRunSelect (portal=portal@entry=0x8f1bb118,
forward=<optimized out>, count=0, count@entry=9223372036854775807,
dest=dest@entry=0x9c0e5ac0) at pquery.c:941
queryDesc = 0x8f0c4118
direction = <optimized out>
nprocessed = <optimized out>
#44 0x00000000007fe9ac in PortalRun (portal=portal@entry=0x8f1bb118,
count=<optimized out>, isTopLevel=<optimized out>, run_once=<optimized out>,
dest=dest@entry=0x9c0e5ac0, altdest=<optimized out>, altdest@entry=0x9c0e5ac0,
completionTag=completionTag@entry=0x80dcc600 "") at pquery.c:782
local_sigjmp_buf = {{_sjb = {39880966407320031677760141056,
39880979966010995407360602392, 187685733495171179383451648,
190481374453030011741065216, 190481374453030011501593456,
190481374453030011958158488, 154633964268542829522634112, 0, 0, 0, 0,
190481374453030009349963776, 44278112641986830462506340352,
44278015390752073865739895040, 44278112641986830462496014336,
44278015390752073865750220800, 44278112641986830462506340352,
178417203828823964744729792, 44278112641986830462506340352,
44278112641986830462496014336, 2508757194026898849792,
139742645647600056885101824, 44278112641986830462496014336,
44269156378804163003395729888, 178433289389656239473739056,
178409161048407827380225344, 79418643888717367602887016960,
44289987917951721725845295384, 178402815368446471294469488,
36893488149820526592, 178439708856593890397701520, 18446744076110974976}}}
save_exception_stack = 0x80dcc790
save_context_stack = 0x0
saveTopTransactionResourceOwner = 0x8f1a15d8
saveTopTransactionContext = 0x8f0e6000
saveResourceOwner = 0x9c136498
savePortalContext = 0x0
saveActivePortal = 0x0
saveMemoryContext = 0x8f22d000
result = <optimized out>
nprocessed = <optimized out>
#45 0x00000000007fd9a0 in exec_simple_query
(query_string=query_string@entry=0x8f0a8118 "select final > 1 as multibatch\n
from hash_join_batches(\n$$\n select count(*) from join_foo\n left join
(select b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss\n on
join_foo.id < ss.i"...) at postgres.c:1144
parsetree = 0x8f0a94d0
portal = 0x8f1bb118
completionTag =
"\000\306܀\000\000\000\000p\306܀\000\000\000\000\000@\233\000\000\000\000\000f\"\313c\000\000\000\000`\306܀\000\000\000\000\324\v\222\000\000\000\000\000\000\220\235\000\000\000\000\000XI\233\000\000\000\000"
format = 0
commandTag = 0x2d0a4c "SELECT"
snapshot_set = <optimized out>
querytree_list = <optimized out>
plantree_list = <optimized out>
receiver = 0x9c0e5ac0
msec_str =
"\000\306܀\000\000\000\000p\306܀\000\000\000\000\000@\233\000\000\000\000\000f\"\313c\000\000\000"
dest = DestRemote
was_logged = <optimized out>
oldcontext = 0x8f22d000
parsetree_list = 0x8f0a9530
parsetree_item = 0x8f0a9508
save_log_statement_stats = <optimized out>
use_implicit_block = <optimized out>
#46 0x00000000007fb804 in PostgresMain (argc=<optimized out>, argv=<optimized
out>, dbname=<optimized out>, username=<optimized out>) at postgres.c:4225
query_string = 0x8f0a8118 "select final > 1 as multibatch\n from
hash_join_batches(\n$$\n select count(*) from join_foo\n left join (select
b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss\n on
join_foo.id < ss.i"...
input_message = {data = 0x8f0a8118 "select final > 1 as multibatch\n
from hash_join_batches(\n$$\n select count(*) from join_foo\n left join
(select b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss\n on
join_foo.id < ss.i"..., len = 240, maxlen = 1024, cursor = 240}
local_sigjmp_buf = {{_sjb = {39880982935602721721518388993,
151115727451830808790928, 190330258725578180701192192,
190481374453030009349967872, 39880996937015543217747132417,
2158269056626417435296, 154354828137219456587582000, 0, 0, 0, 0, 0,
18446744076094214272, 44270271447589930598356161136, 1,
39880992952518823296483983360, 44287198179951966482935153624,
44287201279004970866139825112, -5321102661161709925256572094123735246, 0, 0, 0,
0, 0, 0, 0, 44270271447589930595971497985, 18446744076109447888,
28074974518220166074500006954603847445, 39880995903997875092174195120,
-10061976640049440637326301804240, 41938377208525581068969260040}}}
send_ready_for_query = false
disable_idle_in_transaction_timeout = <optimized out>
firstchar = <optimized out>
#47 0x000000000077987c in BackendRun (port=port@entry=0x8f0d01c0) at
postmaster.c:4422
usecs = <optimized out>
secs = <optimized out>
maxac = <optimized out>
ac = 4
av = 0x8f19d500
i = <optimized out>
#48 0x0000000000778eb0 in BackendStartup (port=0x8f0d01c0) at postmaster.c:4086
bn = 0x8f0b82a0
pid = <optimized out>
save_errno = <optimized out>
#49 ServerLoop () at postmaster.c:1728
port = 0x8f0d01c0
i = 0
rmask = {__fds_bits = {8, 0 <repeats 15 times>}}
selres = <optimized out>
now = <optimized out>
readmask = {__fds_bits = {8, 0 <repeats 15 times>}}
last_lockfile_recheck_time = 1674256910
last_touch_time = 1674256850
nSockets = 4
#50 0x0000000000776444 in PostmasterMain (argc=<optimized out>, argc@entry=3,
argv=<optimized out>, argv@entry=0x80dcd580) at postmaster.c:1401
output_config_variable = <optimized out>
listen_addr_saved = <optimized out>
userDoption = <optimized out>
opt = <optimized out>
i = <optimized out>
status = <optimized out>
#51 0x00000000006e57c4 in main (argc=3, argv=0x80dcd580) at main.c:228
do_check_root = <optimized out>
A debugging session is active.
Inferior 1 [process 94545] will be detached.
Quit anyway? (y or n) [answered Y; input not from terminal]
[Inferior 1 (process 94545) detached]
2023-01-20 23:23:17.984 UTC [94545:756] pg_regress/join LOG: statement: set enable_parallel_hash = on;
2023-01-20 23:23:17.985 UTC [94545:757] pg_regress/join LOG: statement: set parallel_leader_participation = off;
2023-01-20 23:23:17.986 UTC [94545:758] pg_regress/join LOG: statement: set min_parallel_table_scan_size = 0;
2023-01-20 23:23:17.987 UTC [94545:759] pg_regress/join LOG: statement: set parallel_setup_cost = 0;
2023-01-20 23:23:17.988 UTC [94545:760] pg_regress/join LOG: statement: set parallel_tuple_cost = 0;
2023-01-20 23:23:17.988 UTC [94545:761] pg_regress/join LOG: statement: set max_parallel_workers_per_gather = 2;
2023-01-20 23:23:17.989 UTC [94545:762] pg_regress/join LOG: statement: set enable_material = off;
2023-01-20 23:23:17.990 UTC [94545:763] pg_regress/join LOG: statement: set enable_mergejoin = off;
2023-01-20 23:23:17.991 UTC [94545:764] pg_regress/join LOG: statement: set work_mem = '4MB';
2023-01-20 23:23:17.992 UTC [94545:765] pg_regress/join LOG: statement: explain (costs off)
select count(*) from join_foo
left join (select b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss
on join_foo.id < ss.id + 1 and join_foo.id > ss.id - 1;
2023-01-20 23:23:17.994 UTC [94545:766] pg_regress/join LOG: statement: select count(*) from join_foo
left join (select b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss
on join_foo.id < ss.id + 1 and join_foo.id > ss.id - 1;
2023-01-20 23:23:18.125 UTC [94545:767] pg_regress/join LOG: statement: select final > 1 as multibatch
from hash_join_batches(
$$
select count(*) from join_foo
left join (select b1.id, b1.t from join_bar b1 join join_bar b2 using (id)) ss
on join_foo.id < ss.id + 1 and join_foo.id > ss.id - 1;
$$);
2023-01-26 20:05:16.751 UTC [94545:768] pg_regress/join LOG: statement: rollback to settings;