]0;/Users/bertin/Library/xgraph/xg_init.xg: 0% (0 of 3432): line 0.0
Current xgraph info:
 xgraph Python.so examples/PythonBench.xg
 XGraph build version 20060426; gcc4.0.1[Apr 26 2006 22:27:46,"Darwin portia.local 7.9.0 Power Macintosh ; CC='gccopt -DXGRAPH ' ACC='gccopt -DXGRAPH '"]
 Executed d.d. Wed Apr 26 23:30:33 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;Python.so: 0% (0 of 68340): line 0.0You're loading a shared library: will load it as a dynamic module!
Python.c::initDyMod(): Initialising Python.so loaded from ./Python.so, call 1
Loaded module Python.so from ./Python.so, total modules 1
 A dynamic module (library) that contains
 hooks to interface with the Python language.
No numerical data in "Python.so"
]0;examples/PythonBench.xg: 0% (0 of 2506): line 0.0LoadDyMod(Python.so): request ignored because a module with this name has already been loaded.
	Unload that module (Python.so from ./Python.so) first, and try again.
#ac2: 	verbose[ system.time[ no-verbose[ Python-Eval[ "for i in range(N): kk= ascanf.ImportVariable('$loop');" ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.02256401597947183s (0% CPU)
#ac:2 	verbose[0]== 0	->
#ac2: 	verbose[ system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[ "kk= ascanf.ImportVariable('$loop')" ] ] ] ] ] *BUFLEN*
#ac:3 	system.time[0]== <delayed!>	->
## Compilation time: user 0s, system 0s, total 0.001077711553519251s (0% CPU)
#ac:2 	verbose[0]== 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.0005370653779846491s (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.000612479144566997s (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.000369798728795168s (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.01722710850380823s (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.000755494028531795s (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.0005439014460345597s (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.0004544900163023947s (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.0003542819394120374s (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.0009161958822130285s (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.0007795830302314802s (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.0004968627873101743s (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.000356940410320336s (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.0003001901946044109s (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.01608434579479816s (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 0s, system 0s, total 0.0003467948172621352s (0% CPU)
#ac:2 	verbose[0]== 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.0003963291833698213s (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.0003469575807871331s (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.0002447420870884687s (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.0001277151126149979s (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.0003827113017783326s (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.01538647005411562s (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.0001949907029474521s (0% CPU)
#ac:2 	verbose[0]== 0	->
## Compilation time: user 0.01s, system 0s, total 0.107729542144034s (9.28250487376066% CPU)
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ Python-Eval[<C>`"for i in range(N): kk= ascanf.ImportVariable('$loop');"] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 0.23s, system 0s, total 0.3182996984317409s (72.25894373548184% CPU)
#C2 	verbose[0.23]== 0.23	->
#C2: 	verbose[
#C3: 	    system.time[ no-verbose[ for-toMAX[0, N, Python-Eval[<C>`"kk= ascanf.ImportVariable('$loop')"]] ] ]
#C2: 	] *BUFLEN*
#C3 	system.time[0]== <delayed!>	->
#C# Evaluation time 'no-verbose': user 6.64s, system 0.03s, total 7.225662512652152s (92.30987453843595% CPU)
#C2 	verbose[6.64]== 6.64	->
#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.35s, system 0s, total 0.3798496477363283s (92.14172030585944% CPU)
#C2 	verbose[0.35]== 0.35	->
#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.01s, system 0.04s, total 8.823160034306211s (91.23715277406268% CPU)
#C2 	verbose[8.01]== 8.01	->
#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.18s, system 0s, total 0.2563420264970338s (70.21868495764694% CPU)
#C2 	verbose[0.18]== 0.18	->
#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.6s, system 0.02s, total 6.128355912612915s (91.70485657390334% CPU)
#C2 	verbose[5.6]== 5.6	->
#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.210000000000001s, system 0.09s, total 10.23916781613885s (81.06127518407935% CPU)
#C2 	verbose[8.210000000000001]== 8.210000000000001	->
#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.54s, system 0.07000000000000001s, total 8.145227762596161s (81.15181297144193% CPU)
#C2 	verbose[6.54]== 6.54	->
#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.45s, system 0.01s, total 7.307066085463438s (88.40757596063655% CPU)
#C2 	verbose[6.45]== 6.45	->
#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.34s, system 0.07000000000000001s, total 7.372034014538473s (86.95022279277016% CPU)
#C2 	verbose[6.34]== 6.34	->
#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.32s, system 0.14s, total 7.281312609702616s (88.72026715886106% CPU)
#C2 	verbose[6.32]== 6.32	->
#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.5s, system 0.01s, total 6.281334637033s (87.72021104423531% CPU)
#C2 	verbose[5.5]== 5.5	->
#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.54s, system 0.09s, total 6.025074860370598s (76.84551822672643% CPU)
#C2 	verbose[4.54]== 4.54	->
#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 0s, total 0.4254106849262747s (79.92276923155406% 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.14s, system 0s, total 0.2682196947337536s (52.19601794676935% CPU)
#C2 	verbose[0.14]== 0.14	->
#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 0.01s, total 0.2224349119514435s (67.43545726884109% 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.11s, system 0s, total 0.1782611625395624s (61.70721565645974% CPU)
#C2 	verbose[0.11]== 0.11	->
#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 37.04s, system 0.33s, total 42.15997988893886s (88.63856220625104% CPU)
#C2 	verbose[37.04]== 37.04	->
#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.15s, system 0.27s, total 37.22293356513753s (89.78335880356484% CPU)
#C2 	verbose[33.15]== 33.15	->
#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.93s, system 0.01s, total 1.056801703244333s (88.94762348643488% CPU)
#C2 	verbose[0.93]== 0.93	->
#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.3s, system 0s, total 0.3903264645678998s (76.85873934582089% CPU)
#C2 	verbose[0.3]== 0.3	->
#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.43s, system 0.06s, total 0.6495018785080966s (75.44242999350952% CPU)
#C2 	verbose[0.43]== 0.43	->
#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.27s, system 0.04s, total 0.3600355757662039s (86.102602316529% CPU)
#C2 	verbose[0.27]== 0.27	->
#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 3.407183123288813e-05s (0% CPU)
#C2 	verbose[0]== 0	->
#C# Evaluation time 'verbose': user 137.77s, system 1.31s, total 158.9264551384662s (87.51217654658265% CPU)
]0;examples/PythonBench.xg: 100% (2506 of 2506): line 0.35Only (3) command(s) in "examples/PythonBench.xg"
xgraph: maxitems=0, setNumber=0; no data found
Python.c::closeDyMod(1): Closing Python.so loaded from ./Python.so, call 1Python.c calling Python 2.4.3 (#1, Apr 21 2006, 15:29:04) 
[GCC 4.0.1 (Apple Computer, Inc. build 5301)]
100000 1000000

