test_profile: ProfileTest.test_cprofile() failed on AMD64 Windows PGO Tailcall 3.x #159117

Activity

1. vstinner

   added

   testsTests in the Lib/test dirTests in the Lib/test dir

   OS-windows

   topic-profiling

   on Oct 10, 2026
2. vstinner commented on Oct 10, 2026

   

   vstinner

   on Oct 10, 2026

   MemberAuthor

   More actions

   Similar but different failure on s390x Fedora Stable Refleaks 3.15: https://buildbot.python.org/#/builders/2050/builds/381

   This time, the output is not completely empty:

   ======================================================================
   FAIL: test_cprofile (test.test_profile.ProfileTest.test_cprofile)
   ----------------------------------------------------------------------
   Traceback (most recent call last):
     File "/var/lib/buildbot/worker/cstratak-fedora-stable-s390x/3.15.cstratak-fedora-stable-s390x.refleak/build/Lib/test/test_profile.py", line 70, in test_cprofile
       self.fail("\n".join(fail))
       ~~~~~~~~~^^^^^^^^^^^^^^^^^
   AssertionError: 
   Stats.print_stats output for Profile does not fit expectation:
   --- 
   +++ 
   @@ -1,9 +1,4 @@
   -       28   27.972    0.999   27.972    0.999 profilee.py:110(__getattr__)
   -        1  269.996  269.996  999.769  999.769 profilee.py:25(testfunc)
   -     23/3  149.937    6.519  169.917   56.639 profilee.py:35(factorial)
   -       20   19.980    0.999   19.980    0.999 profilee.py:48(mul)
   -        2   39.986   19.993  599.830  299.915 profilee.py:55(helper)
   -        4  115.984   28.996  119.964   29.991 profilee.py:73(helper1)
   -        2   -0.006   -0.003  139.946   69.973 profilee.py:84(helper2_indirect)
   -        8  311.976   38.997  399.912   49.989 profilee.py:88(helper2)
   -        8   63.976    7.997   79.960    9.995 profilee.py:98(subhelper)
   +        1  890.000  890.000  890.000  890.000 profilee.py:110(__getattr__)
   +        1   98.999   98.999  999.996  999.996 profilee.py:25(testfunc)
   +        1    0.999    0.999  900.997  900.997 profilee.py:55(helper)
   +        1    9.999    9.999  899.998  899.998 profilee.py:73(helper1)
   
   Stats.print_callers output for Profile does not fit expectation:
   --- 
   +++ 
   @@ -1,17 +1,5 @@
   -:0(append)                        <- profilee.py:73(helper1)(4)  119.964
   -:0(exception)                     <- profilee.py:73(helper1)(4)  119.964
   -:0(hasattr)                       <- profilee.py:73(helper1)(4)  119.964
   -                                     profilee.py:88(helper2)(8)  399.912
   -profilee.py:110(__getattr__)      <- :0(hasattr)(12)   11.964
   -                                     profilee.py:98(subhelper)(16)   79.960
   -profilee.py:25(testfunc)          <- <string>:1(<module>)(1)  999.767
   -profilee.py:35(factorial)         <- profilee.py:25(testfunc)(1)  999.769
   -                                     profilee.py:35(factorial)(20)  169.917
   -                                     profilee.py:84(helper2_indirect)(2)  139.946
   -profilee.py:48(mul)               <- profilee.py:35(factorial)(20)  169.917
   -profilee.py:55(helper)            <- profilee.py:25(testfunc)(2)  999.769
   -profilee.py:73(helper1)           <- profilee.py:55(helper)(4)  599.830
   -profilee.py:84(helper2_indirect)  <- profilee.py:55(helper)(2)  599.830
   -profilee.py:88(helper2)           <- profilee.py:55(helper)(6)  599.830
   -                                     profilee.py:84(helper2_indirect)(2)  139.946
   -profilee.py:98(subhelper)         <- profilee.py:88(helper2)(8)  399.912
   +:0(hasattr)                   <- profilee.py:73(helper1)(1)  899.998
   +profilee.py:110(__getattr__)  <- :0(hasattr)(1)  889.999
   +profilee.py:25(testfunc)      <- <string>:1(<module>)(1)  999.995
   +profilee.py:55(helper)        <- profilee.py:25(testfunc)(1)  999.996
   +profilee.py:73(helper1)       <- profilee.py:55(helper)(1)  900.997
   
   Stats.print_callees output for Profile does not fit expectation:
   --- 
   +++ 
   @@ -1,17 +1,6 @@
   -:0(hasattr)                       -> profilee.py:110(__getattr__)(12)   27.972
   -<string>:1(<module>)              -> profilee.py:25(testfunc)(1)  999.769
   -profilee.py:110(__getattr__)      ->
   -profilee.py:25(testfunc)          -> profilee.py:35(factorial)(1)  169.917
   -                                     profilee.py:55(helper)(2)  599.830
   -profilee.py:35(factorial)         -> profilee.py:35(factorial)(20)  169.917
   -                                     profilee.py:48(mul)(20)   19.980
   -profilee.py:48(mul)               ->
   -profilee.py:55(helper)            -> profilee.py:73(helper1)(4)  119.964
   -                                     profilee.py:84(helper2_indirect)(2)  139.946
   -                                     profilee.py:88(helper2)(6)  399.912
   -profilee.py:73(helper1)           -> :0(append)(4)   -0.004
   -profilee.py:84(helper2_indirect)  -> profilee.py:35(factorial)(2)  169.917
   -                                     profilee.py:88(helper2)(2)  399.912
   -profilee.py:88(helper2)           -> :0(hasattr)(8)   11.964
   -                                     profilee.py:98(subhelper)(8)   79.960
   -profilee.py:98(subhelper)         -> profilee.py:110(__getattr__)(16)   27.972
   +:0(hasattr)                   -> profilee.py:110(__getattr__)(1)  890.000
   +<string>:1(<module>)          -> profilee.py:25(testfunc)(1)  999.996
   +profilee.py:110(__getattr__)  ->
   +profilee.py:25(testfunc)      -> profilee.py:55(helper)(1)  900.997
   +profilee.py:55(helper)        -> profilee.py:73(helper1)(1)  899.998
   +profilee.py:73(helper1)       -> :0(hasattr)(1)  889.999
   
   ----------------------------------------------------------------------
   Ran 625 tests in 54.221s
   
   FAILED (failures=1, skipped=1)
   test test_profiling failed
   
3. vstinner

   added

   type-bugAn unexpected behavior, bug, or errorAn unexpected behavior, bug, or error

   on Oct 10, 2026