]0;/Users/bertin/Library/xgraph/xg_init.xg: 0% (0 of 3432): line 0.0
Current xgraph info:
 xgraph examples/PythonBench.xg
 XGraph build version 20060426; gcc4.0.1[Apr 28 2006 00:20:39,"Darwin portia.local 7.9.0 Power Macintosh ; CC='gccopt -DXGRAPH ' ACC='gccopt -DXGRAPH '"]
 Executed d.d. Fri Apr 28 15:04:49 2006
 Working directory: /Volumes/Debian/Users/bertin/work/src/xgraph
 Last opened on display :0.0/-1/-1 (visual 0x22, 24 planes TrueColor) by bertin


]0;examples/PythonBench.xg: 0% (0 of 2729): line 0.0Python/Python.c::initDyMod(): Initialising Python.so loaded from ./Python.so, call 1
Python/Python.c calling Python 2.4.3 (#1, Apr 21 2006, 15:29:04) 
[GCC 4.0.1 (Apple Computer, Inc. build 5301)]
#ac2: 	verbose[ system.time[ no-verbose[ Python-EvalValue[ "for i in range(N): ascanf.ReturnValue= ascanf.ImportVariable('$loop');" ] ] ], ?Python-EvalValue ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.002085217773256087s (0% CPU)
#ac:2 	verbose[0,NaN]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.ReturnValue= ascanf.ImportVariable('$loop')" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0.01s, system 0s, total 0.01355462083477289s (73.77557898444566% CPU)
#ac:2 	verbose[0.01]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-EvalValue[ "ascanf.ReturnValue= ascanf.ImportVariable('$loop')" ] ] ] ], ?Python-EvalValue ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0008588488669054444s (0% CPU)
#ac:2 	verbose[0,NaN]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N): kk= int(ascanf.ImportVariable('$loop'));" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0004460805675108379s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "kk= int(ascanf.ImportVariable('$loop'))" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0004768428737354359s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N): ascanf.ImportVariable('$loop');" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0004689217155188728s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.ImportVariable('$loop')" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0005726020809425181s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.NoOp(string='$loop',int=kk)" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0003444618734038324s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.NoOp(kk,'$loop')" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.01339869337782493s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.NoOp(1,'$loop')" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0006644549635496512s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.NoOp(string='$loop')" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0004349041387943173s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.NoOp(int=1)" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0003460895086538111s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.NoOp(1)" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0003160867655458698s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "ascanf.NoOp()" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0003452756910288218s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N): ascanf.NoOp(int=kk,string='$loop');" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0002774033011047086s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N): ascanf.NoOp(kk,'$loop');" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0002477260850467631s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N): ascanf.NoOp(1);" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0003904696964698979s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N): ascanf.NoOp();" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0.01s, system 0s, total 0.01327190059185158s (75.34715868908484% CPU)
#ac:2 	verbose[0.01]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N2, Python-Eval[ "kk" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0005372823960179795s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N2, Python-Eval[ "1" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0003614435345119438s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N2, Python-Eval[ 0 ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0002733342129797618s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N2, $loop ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0001383489962481923s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N2): i;" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0007780096494898341s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N2, 0 ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0001994395726307274s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N2 ] ] ] ] *BUFLEN*
#ac5 	 for-toMAX[0, N2 ]  :
#ac5 	"for-toMAX[0, N2 ]" warning: function call with only 2 parameters
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.0001709017012477669s (0% CPU)
#ac:2 	verbose[0]== 0	->
## Compilation time: user 0.02s, system 0s, total 0.05771925548925414s (34.65048159487% CPU)
100000 1000000
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-EvalValue[<C>
#C3: 	    `"for i in range(N): ascanf.ReturnValue= ascanf.ImportVariable('$loop');"] ] ], 
#C3: 	    ?Python-EvalValue
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.27s, system 0s, total 0.3666982464074835s (73.63002213541262% CPU)
#C2 	verbose[0.27,0]== return[0]== 0	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>
#C3: 	        `"ascanf.ReturnValue= ascanf.ImportVariable('$loop')"]
#C3: 	    ] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 7.41s, system 0.01s, total 8.092402806303593s (91.69093750771003% CPU)
#C2 	verbose[7.41]== 7.41	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-EvalValue[<C>
#C3: 	        `"ascanf.ReturnValue= ascanf.ImportVariable('$loop')"]
#C3: 	    ] ] ], ?Python-EvalValue
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 7.35s, system 0.04s, total 8.275693199002065s (89.2976554627609% CPU)
#C2 	verbose[7.35,99999]== return[0]== 0	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>
#C3: 	    `"for i in range(N): kk= int(ascanf.ImportVariable('$loop'));"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.33s, system 0s, total 0.3964326467172116s (83.24238751088525% CPU)
#C2 	verbose[0.33]== 0.33	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"kk= int(ascanf.ImportVariable('$loop'))"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 8.390000000000001s, system 0.01s, total 9.161366959698883s (91.68937383418699% CPU)
#C2 	verbose[8.390000000000001]== 8.390000000000001	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>`"for i in range(N): ascanf.ImportVariable('$loop');"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.22s, system 0s, total 0.2607052825661602s (84.38647573018386% CPU)
#C2 	verbose[0.22]== 0.22	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.ImportVariable('$loop')"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 5.76s, system 0.01s, total 6.273795322046081s (91.96984765703549% CPU)
#C2 	verbose[5.76]== 5.76	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.NoOp(string='$loop',int=kk)"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 8.359999999999999s, system 0.04s, total 9.154747746918778s (91.75566855817731% CPU)
#C2 	verbose[8.359999999999999]== 8.359999999999999	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.NoOp(kk,'$loop')"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 6.61s, system 0.03s, total 7.205094574288745s (92.15701378431207% CPU)
#C2 	verbose[6.61]== 6.61	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.NoOp(1,'$loop')"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 6.4s, system 0.01s, total 7.140586452171831s (89.76853712135058% CPU)
#C2 	verbose[6.4]== 6.4	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.NoOp(string='$loop')"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 6.65s, system 0.01s, total 7.12696536956435s (93.44790741430396% CPU)
#C2 	verbose[6.65]== 6.65	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.NoOp(int=1)"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 6.44s, system 0.01s, total 7.04619087777718s (91.53882022047554% CPU)
#C2 	verbose[6.44]== 6.44	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.NoOp(1)"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 5.58s, system 0s, total 6.06735675507692s (91.96756059104123% CPU)
#C2 	verbose[5.58]== 5.58	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"ascanf.NoOp()"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 4.66s, system 0.02s, total 5.232054019260785s (89.44861774690197% CPU)
#C2 	verbose[4.66]== 4.66	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>`"for i in range(N): ascanf.NoOp(int=kk,string='$loop');"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.34s, system 0.01s, total 0.4109627636118051s (85.16586683522732% CPU)
#C2 	verbose[0.34]== 0.34	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>`"for i in range(N): ascanf.NoOp(kk,'$loop');"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.18s, system 0.02s, total 0.2505760743694758s (79.81608000814111% CPU)
#C2 	verbose[0.18]== 0.18	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>`"for i in range(N): ascanf.NoOp(1);"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.14s, system 0s, total 0.2297305156869315s (60.94096797779663% CPU)
#C2 	verbose[0.14]== 0.14	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>`"for i in range(N): ascanf.NoOp();"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.13s, system 0s, total 0.175612348933747s (74.02668479142368% CPU)
#C2 	verbose[0.13]== 0.13	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N2, Python-Eval[<C>`"kk"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 38.01s, system 0.12s, total 42.22732204955303s (90.29698818043707% CPU)
#C2 	verbose[38.01]== 38.01	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N2, Python-Eval[<C>`"1"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 33.55s, system 0.05s, total 36.14740678641433s (92.9527260379526% CPU)
#C2 	verbose[33.55]== 33.55	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N2, Python-Eval[<C>0]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.9s, system 0s, total 1.013879225558127s (88.76796933131379% CPU)
#C2 	verbose[0.9]== 0.9	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[<C>0, N2, $loop] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.26s, system 0s, total 0.3622503533053583s (71.77356698968723% CPU)
#C2 	verbose[0.26]== 0.26	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>`"for i in range(N2): i;"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.5s, system 0.04s, total 0.6228948165676775s (86.69200411323844% CPU)
#C2 	verbose[0.5]== 0.5	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[<C>0, N2, 0] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.28s, system 0s, total 0.3622570266098832s (77.29318672444516% CPU)
#C2 	verbose[0.28]== 0.28	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[<C>0, N2] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0s, system 0s, total 0.0002087170935556061s (0% CPU)
#C2 	verbose[0]== 0	->
#C# Evaluation time 'verbose': user 148.72s, system 0.45s, total 164.0195582077089s (90.94647103676265% CPU)
]0;examples/PythonBench.xg: 100% (2729 of 2729): line 0.36Only (3) command(s) in "examples/PythonBench.xg"
xgraph: maxitems=0, setNumber=0; no data found
Python/Python.c::closeDyMod(1): Closing Python.so loaded from ./Python.so, call 1 (ignoring attempt to close a file opened elsewhere!) 
