[pypy-dev] Profiling results
Michael Hudson
mwh at python.net
Fri Jun 13 15:51:29 CEST 2003
Armin and I are on IRC talking about mhy my new types module takes so
long to load and this is a bit big for that medium :-)
>>> profile.run("main.run_string('import types', '', space)")
the slice is empty
1167131 function calls (876696 primitive calls) in 36.760 CPU seconds
Ordered by: standard name
ncalls tottime percall cumtime percall filename:lineno(function)
1 0.000 0.000 36.760 36.760 <string>:1(?)
4 0.000 0.000 0.000 0.000 appfile.py:38(__init__)
44 0.000 0.000 0.380 0.009 appfile.py:45(get)
44/1 0.000 0.000 36.680 36.680 appfile.py:51(call)
4 0.000 0.000 0.090 0.022 appfile.py:58(runbytecode)
4 0.000 0.000 0.090 0.022 appfile.py:73(__init__)
208 0.060 0.000 0.180 0.001 baseobjspace.py:108(unpacktuple)
706 0.040 0.000 0.720 0.001 baseobjspace.py:122(exception_match)
2 0.000 0.000 0.020 0.010 baseobjspace.py:154(call_function)
3 0.000 0.000 0.000 0.000 baseobjspace.py:37(get_builtin_module)
101 0.040 0.000 0.040 0.000 baseobjspace.py:49(getexecutioncontext)
44 0.010 0.000 0.100 0.002 baseobjspace.py:61(gethelper)
22094 2.340 0.000 16.390 0.001 baseobjspace.py:74(is_)
22362 0.180 0.000 0.180 0.000 baseobjspace.py:80(newbool)
197 0.060 0.000 0.610 0.003 baseobjspace.py:86(unpackiterable)
44367 0.350 0.000 0.350 0.000 boolobject.py:27(bool_is_true)
31 0.000 0.000 0.010 0.000 builtin.py:103(len)
1 0.000 0.000 0.010 0.010 builtin.py:112(getattr)
58 0.000 0.000 0.080 0.001 builtin.py:139(issubclass)
3/1 0.000 0.000 36.600 36.600 builtin.py:36(__import__)
3 0.000 0.000 0.000 0.000 builtin.py:71(compile)
32 0.000 0.000 0.000 0.000 cpythonobject.py:131(cpython_f)
56 0.000 0.000 0.040 0.001 cpythonobject.py:139(cpython_f)
121 0.000 0.000 0.000 0.000 cpythonobject.py:20(cpython_unwrap)
52 0.000 0.000 0.000 0.000 cpythonobject.py:8(__init__)
44158 1.780 0.000 3.480 0.000 default.py:37(default_id)
7 0.000 0.000 0.010 0.001 default.py:46(default_not)
38 0.000 0.000 0.010 0.000 default.py:64(default_inplace)
810 0.010 0.000 0.010 0.000 dictobject.py:10(__init__)
8 0.000 0.000 0.000 0.000 dictobject.py:109(len_dict)
1783 0.030 0.000 0.040 0.000 dictobject.py:13(get)
452 0.010 0.000 0.010 0.000 dictobject.py:18(set)
7 0.000 0.000 0.000 0.000 dictobject.py:21(make_empty)
42721 0.270 0.000 0.270 0.000 dictobject.py:26(is_empty)
475 0.080 0.000 0.270 0.001 dictobject.py:38(__init__)
2436 0.580 0.000 0.840 0.000 dictobject.py:47(non_empties)
452 0.040 0.000 0.350 0.001 dictobject.py:51(_cell)
240 0.010 0.000 0.010 0.000 dictobject.py:71(dict_is_true)
2181 1.350 0.001 30.100 0.014 dictobject.py:84(getitem_dict_any)
452 0.030 0.000 0.390 0.001 dictobject.py:93(setitem_dict_any_any)
7 0.000 0.000 0.170 0.024 dictobject.py:99(delitem_dict_any)
4 0.000 0.000 0.000 0.000 executioncontext.py:18(get_w_builtins)
197 0.000 0.000 0.000 0.000 executioncontext.py:202(__init__)
2948 0.030 0.000 0.030 0.000 executioncontext.py:205(push)
2948 0.030 0.000 0.030 0.000 executioncontext.py:208(pop)
434 0.000 0.000 0.000 0.000 executioncontext.py:211(top)
110 0.000 0.000 0.000 0.000 executioncontext.py:216(depth)
142 0.010 0.000 0.010 0.000 executioncontext.py:219(empty)
4 0.000 0.000 0.000 0.000 executioncontext.py:24(make_standard_w_globals)
8 0.000 0.000 0.000 0.000 executioncontext.py:31(exception_trace)
1 0.000 0.000 0.000 0.000 executioncontext.py:5(__init__)
804 0.010 0.000 0.010 0.000 executioncontext.py:56(__init__)
8 0.000 0.000 0.000 0.000 executioncontext.py:62(record_application_traceback)
698 0.050 0.000 0.890 0.001 executioncontext.py:65(match)
8 0.000 0.000 0.000 0.000 executioncontext.py:88(record_interpreter_traceback)
98/1 0.010 0.000 36.730 36.730 executioncontext.py:9(eval_frame)
93/1 0.010 0.000 36.600 36.600 extmodule.py:40(eval_code)
3 0.000 0.000 0.000 0.000 extmodule.py:7(__get__)
62 0.000 0.000 0.000 0.000 funcobject.py:11(__init__)
215/1 0.010 0.000 36.670 36.670 funcobject.py:35(func_call)
44 0.000 0.000 0.010 0.000 funcobject.py:47(func_get)
1 0.000 0.000 0.010 0.010 funcobject.py:52(func_getattr)
42/25 0.000 0.000 14.460 0.578 instmethobject.py:31(instmeth_call)
44 0.010 0.000 0.010 0.000 instmethobject.py:9(__init__)
31 0.000 0.000 0.000 0.000 intobject.py:102(int_int_gt)
15 0.000 0.000 0.000 0.000 intobject.py:108(int_int_ge)
61 0.010 0.000 0.010 0.000 intobject.py:141(int_int_add)
46 0.010 0.000 0.010 0.000 intobject.py:153(int_int_sub)
23 0.000 0.000 0.000 0.000 intobject.py:177(int_int_floordiv)
46676 1.490 0.000 1.810 0.000 intobject.py:26(__init__)
39 0.000 0.000 0.000 0.000 intobject.py:323(int_is_true)
16 0.000 0.000 0.000 0.000 intobject.py:385(int_int_and)
1167 0.010 0.000 0.010 0.000 intobject.py:46(int_unwrap)
114 0.000 0.000 0.000 0.000 intobject.py:78(int_int_lt)
23 0.000 0.000 0.000 0.000 intobject.py:84(int_int_le)
22102 0.370 0.000 0.550 0.000 intobject.py:90(int_int_eq)
393 0.010 0.000 0.470 0.001 iterobject.py:22(next_seqiter)
205 0.000 0.000 0.000 0.000 iterobject.py:8(__init__)
8 0.000 0.000 0.000 0.000 listobject.py:109(list_int_mul)
20 0.000 0.000 0.000 0.000 listobject.py:13(__init__)
15 0.000 0.000 0.000 0.000 listobject.py:166(setitem_list_int)
19 0.000 0.000 0.000 0.000 listobject.py:211(_roundupsize)
29 0.000 0.000 0.000 0.000 listobject.py:260(_list_resize)
2 0.000 0.000 0.010 0.005 listobject.py:35(list_unwrap)
16 0.000 0.000 0.000 0.000 listobject.py:52(getitem_list_int)
8 0.000 0.000 0.000 0.000 listobject.py:84(list_iter)
1 0.000 0.000 0.000 0.000 listobject.py:90(list_add)
1 0.000 0.000 36.760 36.760 main.py:7(run_string)
7 0.000 0.000 0.060 0.009 moduleobject.py:21(getattr_module_any)
2 0.000 0.000 0.000 0.000 moduleobject.py:33(setattr_module_any_any)
3 0.000 0.000 0.010 0.003 moduleobject.py:9(__init__)
37 0.000 0.000 0.000 0.000 multimethod.py:103(is_empty)
140658 1.070 0.000 1.070 0.000 multimethod.py:109(__init__)
140654/53 6.020 0.000 36.720 0.693 multimethod.py:113(__call__)
4 0.000 0.000 0.000 0.000 multimethod.py:12(__init__)
140685/53 9.800 0.000 36.720 0.693 multimethod.py:136(perform_call)
33 0.000 0.000 0.000 0.000 multimethod.py:158(is_empty)
116 0.000 0.000 0.000 0.000 multimethod.py:24(register)
140788 3.330 0.000 4.400 0.000 multimethod.py:36(__get__)
4 0.000 0.000 0.000 0.000 multimethod.py:41(cache_dependency)
140685 1.380 0.000 1.560 0.000 multimethod.py:44(buildchoices)
3065/134 0.180 0.000 0.180 0.001 multimethod.py:56(internal_buildchoices)
4 0.000 0.000 0.000 0.000 multimethod.py:96(slicetable)
173 0.000 0.000 0.030 0.000 objectobject.py:120(object_type)
164 0.060 0.000 0.770 0.005 objectobject.py:28(object_getattr)
17 0.000 0.000 0.070 0.004 objectobject.py:74(object_setattr)
12 0.000 0.000 0.000 0.000 objecttype.py:14(objecttype_new)
52116 0.380 0.000 0.380 0.000 objspace.py:16(__init__)
389 0.010 0.000 0.030 0.000 objspace.py:173(get_typeinstance)
5405/5372 0.280 0.000 0.830 0.000 objspace.py:183(wrap)
79 0.000 0.000 0.000 0.000 objspace.py:19(get_builtin_impl_class)
378 0.040 0.000 0.060 0.000 objspace.py:215(newtuple)
11 0.000 0.000 0.000 0.000 objspace.py:219(newlist)
472 0.040 0.000 0.310 0.001 objspace.py:223(newdict)
16 0.000 0.000 0.000 0.000 objspace.py:227(newslice)
62 0.000 0.000 0.000 0.000 objspace.py:232(newfunction)
3 0.000 0.000 0.010 0.003 objspace.py:237(newmodule)
1 0.000 0.000 0.000 0.000 objspace.py:26(registerimplementation)
7 0.000 0.000 0.010 0.001 opcode.py:14(__call__)
15 0.000 0.000 4.590 0.306 opcode.py:140(slice)
7 0.000 0.000 2.060 0.294 opcode.py:149(SLICE_1)
8 0.000 0.000 2.530 0.316 opcode.py:153(SLICE_2)
31 0.000 0.000 0.040 0.001 opcode.py:205(STORE_SUBSCR)
190 0.010 0.000 0.120 0.001 opcode.py:23(__call__)
7 0.000 0.000 0.000 0.000 opcode.py:238(BREAK_LOOP)
1 0.000 0.000 3.780 3.780 opcode.py:244(RAISE_VARARGS)
2 0.000 0.000 0.000 0.000 opcode.py:271(LOAD_LOCALS)
97 0.000 0.000 0.000 0.000 opcode.py:274(RETURN_VALUE)
1 0.000 0.000 0.000 0.000 opcode.py:278(YIELD_VALUE)
14 0.000 0.000 0.000 0.000 opcode.py:297(POP_BLOCK)
2 0.000 0.000 0.020 0.010 opcode.py:313(BUILD_CLASS)
69 0.000 0.000 0.140 0.002 opcode.py:322(STORE_NAME)
7 0.000 0.000 0.170 0.024 opcode.py:328(DELETE_NAME)
1123 0.110 0.000 8.770 0.008 opcode.py:35(LOAD_FAST)
17 0.000 0.000 0.710 0.042 opcode.py:350(STORE_ATTR)
60 0.000 0.000 6.860 0.114 opcode.py:376(LOAD_NAME)
254 0.020 0.000 10.160 0.040 opcode.py:406(LOAD_GLOBAL)
49 0.000 0.000 0.010 0.000 opcode.py:477(BUILD_TUPLE)
350 0.030 0.000 0.070 0.000 opcode.py:48(LOAD_CONST)
11 0.010 0.001 0.010 0.001 opcode.py:483(BUILD_LIST)
8 0.000 0.000 0.000 0.000 opcode.py:489(BUILD_MAP)
156 0.020 0.000 0.610 0.004 opcode.py:495(LOAD_ATTR)
114 0.020 0.000 0.060 0.001 opcode.py:503(cmp_lt)
23 0.000 0.000 0.000 0.000 opcode.py:504(cmp_le)
8 0.000 0.000 0.000 0.000 opcode.py:505(cmp_eq)
31 0.010 0.000 0.010 0.000 opcode.py:507(cmp_gt)
15 0.000 0.000 0.000 0.000 opcode.py:508(cmp_ge)
62 0.000 0.000 0.010 0.000 opcode.py:514(cmp_is)
8 0.000 0.000 0.000 0.000 opcode.py:518(cmp_exc_match)
344 0.020 0.000 0.460 0.001 opcode.py:52(STORE_FAST)
261 0.000 0.000 0.090 0.000 opcode.py:534(COMPARE_OP)
3/1 0.000 0.000 36.730 36.730 opcode.py:544(IMPORT_NAME)
1 0.000 0.000 0.100 0.100 opcode.py:557(IMPORT_FROM)
104 0.000 0.000 0.000 0.000 opcode.py:564(JUMP_FORWARD)
374 0.070 0.000 0.180 0.000 opcode.py:567(JUMP_IF_FALSE)
15 0.000 0.000 0.000 0.000 opcode.py:572(JUMP_IF_TRUE)
23 0.000 0.000 0.000 0.000 opcode.py:577(JUMP_ABSOLUTE)
391 0.010 0.000 0.010 0.000 opcode.py:58(POP_TOP)
8 0.000 0.000 0.000 0.000 opcode.py:580(GET_ITER)
16 0.000 0.000 0.000 0.000 opcode.py:585(FOR_ITER)
17 0.000 0.000 0.000 0.000 opcode.py:599(SETUP_LOOP)
38 0.000 0.000 0.000 0.000 opcode.py:603(SETUP_EXCEPT)
164/1 0.010 0.000 36.610 36.610 opcode.py:611(call_function_extra)
156/1 0.000 0.000 36.610 36.610 opcode.py:637(CALL_FUNCTION)
8 0.000 0.000 15.470 1.934 opcode.py:640(CALL_FUNCTION_VAR)
30 0.010 0.000 0.030 0.001 opcode.py:649(MAKE_FUNCTION)
15 0.000 0.000 0.000 0.000 opcode.py:67(ROT_THREE)
1040 0.000 0.000 0.000 0.000 opcode.py:684(SET_LINENO)
5339 0.050 0.000 0.050 0.000 opcode.py:715(has_arg)
804/577 0.020 0.000 4.780 0.008 opcode.py:718(dispatch_noarg)
4535/6 0.140 0.000 36.730 6.122 opcode.py:726(dispatch_arg)
24 0.010 0.000 0.010 0.000 opcode.py:85(DUP_TOP)
6 0.000 0.000 0.000 0.000 posixpath.py:168(exists)
6 0.000 0.000 0.000 0.000 posixpath.py:44(join)
1 0.000 0.000 36.760 36.760 profile:0(main.run_string('import types', '', space))
0 0.000 0.000 profile:0(profiler)
93/1 0.000 0.000 36.660 36.660 pycode.py:113(eval_code)
493 0.000 0.000 0.000 0.000 pycode.py:29(__init__)
215/153 0.080 0.000 13.660 0.089 pycode.py:37(build_arguments)
37 0.000 0.000 0.000 0.000 pycode.py:76(__init__)
37/7 0.000 0.000 0.000 0.000 pycode.py:91(_from_code)
55 0.000 0.000 0.000 0.000 pyframe.py:140(__init__)
55 0.000 0.000 0.000 0.000 pyframe.py:144(cleanupstack)
14 0.000 0.000 0.000 0.000 pyframe.py:148(cleanup)
7 0.000 0.000 0.000 0.000 pyframe.py:160(unroll)
34/12 0.000 0.000 24.180 2.015 pyframe.py:179(unroll)
98 0.000 0.000 4.690 0.048 pyframe.py:22(__init__)
112/30 0.010 0.000 24.180 0.806 pyframe.py:250(unrollstack)
97 0.000 0.000 0.000 0.000 pyframe.py:283(emptystack)
1 0.000 0.000 0.000 0.000 pyframe.py:291(unrollstack)
98/1 0.200 0.002 36.730 36.730 pyframe.py:33(eval)
14409 0.220 0.000 0.220 0.000 pyframe.py:70(nextop)
4535 0.180 0.000 0.290 0.000 pyframe.py:75(nextarg)
350 0.000 0.000 0.000 0.000 pyframe.py:80(getconstant)
1467 0.010 0.000 0.010 0.000 pyframe.py:83(getlocalvarname)
567 0.010 0.000 0.010 0.000 pyframe.py:86(getname)
98 0.010 0.000 4.690 0.048 pyframe.py:99(load_builtins)
4053 0.040 0.000 0.040 0.000 rarray.py:19(__init__)
4053 0.150 0.000 0.150 0.000 rarray.py:22(setvalue)
910 0.040 0.000 0.040 0.000 rarray.py:30(hash)
1239 0.000 0.000 0.000 0.000 rarray.py:35(value)
27946 0.210 0.000 0.210 0.000 rarray.py:43(charat)
4053 0.180 0.000 0.370 0.000 rarray.py:8(CharArrayFromStr)
16 0.000 0.000 0.000 0.000 restricted_int.py:104(__and__)
71 0.000 0.000 0.000 0.000 restricted_int.py:158(__new__)
30 0.000 0.000 0.000 0.000 restricted_int.py:161(__add__)
11 0.000 0.000 0.000 0.000 restricted_int.py:177(__mul__)
11 0.000 0.000 0.000 0.000 restricted_int.py:215(__lshift__)
84 0.000 0.000 0.000 0.000 restricted_int.py:22(__add__)
11 0.000 0.000 0.000 0.000 restricted_int.py:230(__rrshift__)
46 0.000 0.000 0.000 0.000 restricted_int.py:28(__sub__)
31 0.000 0.000 0.000 0.000 restricted_int.py:38(__mul__)
23 0.000 0.000 0.000 0.000 restricted_int.py:46(__div__)
8 0.000 0.000 0.000 0.000 restricted_int.py:76(__lshift__)
24 0.000 0.000 0.000 0.000 restricted_int.py:88(__rshift__)
16 0.000 0.000 0.000 0.000 sliceobject.py:13(__init__)
15 0.000 0.000 4.550 0.303 sliceobject.py:18(indices)
45 0.030 0.001 0.180 0.004 sliceobject.py:29(getattr_slice_any)
1 0.000 0.000 0.010 0.010 slicetype.py:9(slicetype_new)
329 0.010 0.000 0.010 0.000 stringobject.py:188(str_unwrap)
4053 0.100 0.000 0.500 0.000 stringobject.py:19(__init__)
910 0.030 0.000 0.110 0.000 stringobject.py:198(str_hash)
21284 2.040 0.000 21.370 0.001 stringobject.py:211(string_richcompare)
21284 0.490 0.000 21.860 0.001 stringobject.py:277(str_str_eq)
492 0.010 0.000 0.030 0.000 tupleobject.py:10(__init__)
8 0.000 0.000 0.000 0.000 tupleobject.py:29(tuple_is_true)
231 0.000 0.000 0.030 0.000 tupleobject.py:34(tuple_len)
860 0.020 0.000 0.060 0.000 tupleobject.py:40(getitem_tuple_int)
15 0.020 0.001 4.580 0.305 tupleobject.py:51(getitem_tuple_slice)
197 0.000 0.000 0.000 0.000 tupleobject.py:67(tuple_iter)
50 0.000 0.000 0.000 0.000 tupleobject.py:73(tuple_add)
8 0.000 0.000 0.080 0.010 tupletype.py:11(tupletype_new)
32 0.000 0.000 0.000 0.000 typeobject.py:109(getdefaults)
64 0.000 0.000 0.000 0.000 typeobject.py:116(slice)
31 0.010 0.000 0.610 0.020 typeobject.py:130(eval_code)
49/37 0.000 0.000 15.000 0.405 typeobject.py:157(type_call)
70 0.000 0.000 0.070 0.001 typeobject.py:164(type_issubtype)
36 0.000 0.000 0.100 0.003 typeobject.py:174(type_getattr)
6 0.030 0.005 0.040 0.007 typeobject.py:18(__init__)
454 0.000 0.000 0.000 0.000 typeobject.py:31(getbases)
538/238 0.040 0.000 0.440 0.002 typeobject.py:39(getmro)
145 0.010 0.000 0.780 0.005 typeobject.py:47(lookup)
233 0.030 0.000 0.110 0.000 typeobject.py:57(lookup_exactly_here)
18 0.000 0.000 0.000 0.000 typeobject.py:69(acceptclass)
13 0.000 0.000 0.000 0.000 typeobject.py:89(hack_out_multimethods)
456 0.010 0.000 0.010 0.000 typeobject.py:96(__init__)
16 0.000 0.000 0.100 0.006 typetype.py:13(typetype_new)
1 0.010 0.010 0.010 0.010 userobject.py:1(?)
12 0.000 0.000 0.140 0.012 userobject.py:20(__init__)
31 0.000 0.000 0.000 0.000 userobject.py:52(get_builtin_impl_class)
12 0.000 0.000 0.090 0.008 userobject.py:59(getsinglebuiltintype)
1 0.000 0.000 0.000 0.000 userobject.py:6(W_UserObject)
15 0.010 0.001 0.010 0.001 userobject.py:74(user_type)
30 0.000 0.000 0.000 0.000 userobject.py:80(user_getdict)
62 0.000 0.000 0.000 0.000 userobject.py:92(build_user_operation)
31 0.000 0.000 1.290 0.042 userobject.py:93(user_operation)
2 0.000 0.000 0.020 0.010 usertype.py:15(__init__)
149 0.010 0.000 0.400 0.003 usertype.py:25(getbases)
94 0.000 0.000 0.380 0.004 usertype.py:32(lookup_exactly_here)
12 0.010 0.001 14.790 1.232 usertype.py:45(usertype_new)
--
Hey, if I thought I was wrong, I'd change my mind. :)
-- Grant Edwards, comp.lang.python
More information about the Pypy-dev
mailing list