32-bit powerpc: bjam stuck compute-bound during poudriere bulk build of devel/boost-libs (during staging)

Sun May 26 07:48:52 UTC 2019

[I misinterpreted.]

On 2019-May-25, at 22:31, Mark Millard <marklmi at yahoo.com> wrote:

> [I retried the build.]
> 
> On 2019-May-25, at 19:49, Mark Millard <marklmi at yahoo.com> wrote:
> 
>> In over 16 minutes of CPU time the log file had 4 lines added:
>> 
>>   - zlib                     : yes (cached)
>>   - bzip2                    : yes (cached)
>>   - lzma                     : yes (cached)
>>   - zstd                     : no  (cached)
>> 
>> after:
>> 
>>   - BOOST_COMP_GNUC >= 4.3.0 : yes (cached)
>> 
>> Using truss showed lack of activity but for rare mmap or clock_gettime
>> calls.
>> 
>> Attaching with gdb showed a backtrace like:
>> 
>> (gdb) bt
>> #0  object_validate (obj=<optimized out>) at object.c:244
>> #1  0x0181a10c in object_equal (lhs=<optimized out>, rhs=<optimized out>) at object.c:334
>> #2  0x01815378 in list_in (l=<optimized out>, value=0x44757c9c) at lists.c:345
>> #3  0x01815418 in list_is_sublist (sub=<optimized out>, l=0x4b826ec0) at lists.c:308
>> #4  0x0180fa70 in function_run (function_=0x41b07800, frame=0xffff9be0, s=0x1844fb4 <result>) at function.c:4128
>> #5  0x01801fe0 in evaluate_rule (rule=0x41b8e89c, rulename=0x41b1becc, frame=0xffff9be0) at compile.c:150
>> #6  0x01810798 in function_call_rule (line=<optimized out>, file=0xffff9be8, unexpanded=<optimized out>, n_args=2, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #7  function_run (function_=0x41bf3580, frame=0xffff9e14, s=0x1844fb4 <result>) at function.c:4617
>> #8  0x01801fe0 in evaluate_rule (rule=0x4209fadc, rulename=0x420bf25c, frame=0xffff9e14) at compile.c:150
>> #9  0x0180f8f0 in function_call_member_rule (line=<optimized out>, file=0x41ae9c5c, rulename=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:605
>> #10 function_run (function_=0x42067140, frame=0xffffa120, s=0x1844fb4 <result>) at function.c:4628
>> #11 0x01801fe0 in evaluate_rule (rule=0x420a18dc, rulename=0x420b262c, frame=0xffffa120) at compile.c:150
>> #12 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffa128, unexpanded=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #13 function_run (function_=0x420cef00, frame=0xffffa354, s=0x1844fb4 <result>) at function.c:4617
>> #14 0x01801fe0 in evaluate_rule (rule=0x42095334, rulename=0x420c063c, frame=0xffffa354) at compile.c:150
>> #15 0x0180f8f0 in function_call_member_rule (line=<optimized out>, file=0x41ae9c5c, rulename=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:605
>> #16 function_run (function_=0x420cdbc0, frame=0xffffa660, s=0x1844fb4 <result>) at function.c:4628
>> #17 0x01801fe0 in evaluate_rule (rule=0x4209402c, rulename=0x41b9ce2c, frame=0xffffa660) at compile.c:150
>> #18 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffa668, unexpanded=<optimized out>, n_args=3, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #19 function_run (function_=0x42227180, frame=0xffffa900, s=0x1844fb4 <result>) at function.c:4617
>> #20 0x01801fe0 in evaluate_rule (rule=0x4227d26c, rulename=0x41b9c73c, frame=0xffffa900) at compile.c:150
>> #21 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffa908, unexpanded=<optimized out>, n_args=3, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #22 function_run (function_=0x422ac8c0, frame=0xffffaba0, s=0x1844fb4 <result>) at function.c:4617
>> #23 0x01801fe0 in evaluate_rule (rule=0x4227cec4, rulename=0x41ba222c, frame=0xffffaba0) at compile.c:150
>> #24 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffaba8, unexpanded=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #25 function_run (function_=0x42227700, frame=0xffffae40, s=0x1844fb4 <result>) at function.c:4617
>> #26 0x01801fe0 in evaluate_rule (rule=0x4226601c, rulename=0x422ad26c, frame=0xffffae40) at compile.c:150
>> #27 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffae48, unexpanded=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #28 function_run (function_=0x422ac880, frame=0xffffb074, s=0x1844fb4 <result>) at function.c:4617
>> #29 0x01801fe0 in evaluate_rule (rule=0x4227ceac, rulename=0x41b9a54c, frame=0xffffb074) at compile.c:150
>> #30 0x0180f8f0 in function_call_member_rule (line=<optimized out>, file=0x41ae9c5c, rulename=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:605
>> #31 function_run (function_=0x42067140, frame=0xffffb380, s=0x1844fb4 <result>) at function.c:4628
>> #32 0x01801fe0 in evaluate_rule (rule=0x420a18dc, rulename=0x420b262c, frame=0xffffb380) at compile.c:150
>> #33 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffb388, unexpanded=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #34 function_run (function_=0x420cef00, frame=0xffffb5b4, s=0x1844fb4 <result>) at function.c:4617
>> #35 0x01801fe0 in evaluate_rule (rule=0x42095334, rulename=0x420c063c, frame=0xffffb5b4) at compile.c:150
>> #36 0x0180f8f0 in function_call_member_rule (line=<optimized out>, file=0x41ae40ec, rulename=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:605
>> #37 function_run (function_=0x41b25980, frame=0xffffba30, s=0x1844fb4 <result>) at function.c:4628
>> #38 0x0181b1c8 in parse_impl (frame=0xffffba30) at parse.c:55
>> #39 0x018100ec in function_run (function_=0x41871d80, frame=0xffffba30, s=0x1844fb4 <result>) at function.c:4860
>> #40 0x01801fe0 in evaluate_rule (rule=0x41a7cd54, rulename=0x41aaf98c, frame=0xffffba30) at compile.c:150
>> #41 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffba38, unexpanded=<optimized out>, n_args=3, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #42 function_run (function_=0x41b25100, frame=0xffffbcd0, s=0x1844fb4 <result>) at function.c:4617
>> #43 0x01801fe0 in evaluate_rule (rule=0x41aa83f4, rulename=0x41aaf74c, frame=0xffffbcd0) at compile.c:150
>> #44 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffbcd8, unexpanded=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #45 function_run (function_=0x41871640, frame=0xffffc250, s=0x1844fb4 <result>) at function.c:4617
>> #46 0x0181b1c8 in parse_impl (frame=0xffffc250) at parse.c:55
>> #47 0x018100ec in function_run (function_=0x41871340, frame=0xffffc250, s=0x1844fb4 <result>) at function.c:4860
>> #48 0x0181b1c8 in parse_impl (frame=0xffffc250) at parse.c:55
>> #49 0x018100ec in function_run (function_=0x41871280, frame=0xffffc250, s=0x1844fb4 <result>) at function.c:4860
>> #50 0x01801fe0 in evaluate_rule (rule=0x41aa8394, rulename=0x41aaf1ac, frame=0xffffc250) at compile.c:150
>> #51 0x01810798 in function_call_rule (line=<optimized out>, file=0xffffc258, unexpanded=<optimized out>, n_args=1, s=<optimized out>, frame=<optimized out>, function=<optimized out>)
>>   at function.c:493
>> #52 function_run (function_=0x418712c0, frame=0xffffccc8, s=0x1844fb4 <result>) at function.c:4617
>> #53 0x0181b1c8 in parse_impl (frame=0xffffccc8) at parse.c:55
>> #54 0x018100ec in function_run (function_=0x41871100, frame=0xffffccc8, s=0x1844fb4 <result>) at function.c:4860
>> #55 0x0181b1c8 in parse_impl (frame=0xffffccc8) at parse.c:55
>> #56 0x018140d0 in main (argc=<optimized out>, argv=<optimized out>, arg_environ=<optimized out>) at jam.c:619
> 
> The retry did not get stuck where indicated --or at all so
> far. (But it is still building.)

I misinterpreted (or was looking at the wrong log file). IT finally
got to where it was the prior time.

I've let it run and the:

bjam --layout=system --prefix=/wrkdirs/usr/ports/devel/boost-libs/work/stage/usr/local -d2 cxxflags=-pipe . . .

has gotten to the stage of cp'ing into areas below /wrkdirs/usr/ports/devel/boost-libs/work/stage/ .
But bjam got over 44 minutes of CPU time getting to that point.

===
Mark Millard
marklmi at yahoo.com
( dsl-only.net went
away in early 2018-Mar)