Project

General

Profile

times.txt

Timing report - Alec Habig, 09/30/2014 10:35 AM

 
1
"Fast" way: SingleGen and SupernovaGen as in the repository.  Truth info suffers.  3.89s/event, of which 3.85s is spent in "simulate".  O(10s) of positrons per event, 10-20 meV per particle.  One MCTruth item used, with positrons Add()'d to that object.
2

    
3
"Slow" way: modified SupernovaGen (see attached patch) to have one positron per MCTruth item, stacked into a vector.  49.0s/event, of which 48.9 is spent in "simulate".
4

    
5
Below are the timing reports for both cases.
6

    
7
"Fast":
8

    
9
TrigReport ---------- Event  Summary ------------
10
TrigReport Events total = 200 passed = 200 failed = 0
11

    
12
TrigReport ---------- Path   Summary ------------
13
TrigReport  Trig Bit#        Run     Passed     Failed      Error Name
14
TrigReport     1    0        200        200          0          0 simulate
15

    
16
TrigReport -------End-Path   Summary ------------
17
TrigReport  Trig Bit#        Run     Passed     Failed      Error Name
18
TrigReport     0    0        200        200          0          0 end_path
19

    
20
TrigReport ---------- Modules in Path: simulate ------------
21
TrigReport  Trig Bit#    Visited     Passed     Failed      Error Name
22
TrigReport     1    0        200        200          0          0 generator
23
TrigReport     1    0        200        200          0          0 geantgen
24
TrigReport     1    0        200        200          0          0 photrans
25
TrigReport     1    0        200        200          0          0 daq
26
TrigReport     1    0        200        200          0          0 rns
27

    
28
TrigReport ------ Modules in End-Path: end_path ------------
29
TrigReport  Trig Bit#    Visited     Passed     Failed      Error Name
30
TrigReport     0    0        200        200          0          0 metadata
31
TrigReport     0    0        200        200          0          0 out1
32

    
33
TrigReport ---------- Module Summary ------------
34
TrigReport    Visited        Run     Passed     Failed      Error Name
35
TrigReport        200        200        200          0          0 daq
36
TrigReport        200        200        200          0          0 geantgen
37
TrigReport        200        200        200          0          0 generator
38
TrigReport        200        200        200          0          0 photrans
39
TrigReport        200        200        200          0          0 rns
40
TrigReport        200        200        200          0          0 metadata
41
TrigReport        200        200        200          0          0 out1
42

    
43
TimeReport ---------- Time  Summary ---[sec]----
44
TimeReport CPU = 778.924043 Real = 775.642079
45

    
46
TimeReport ---------- Event  Summary ---[sec]----
47
TimeReport CPU/event = 3.894620 Real/event = 3.878210
48

    
49
TimeReport ---------- Path   Summary ---[sec]----
50
TimeReport             per event          per path-run 
51
TimeReport        CPU       Real        CPU       Real Name
52
TimeReport   3.850015   3.866183   3.850015   3.866183 simulate
53
TimeReport        CPU       Real        CPU       Real Name
54
TimeReport             per event          per path-run 
55

    
56
TimeReport -------End-Path   Summary ---[sec]----
57
TimeReport             per event       per endpath-run 
58
TimeReport        CPU       Real        CPU       Real Name
59
TimeReport   0.027596   0.027855   0.027596   0.027855 end_path
60
TimeReport        CPU       Real        CPU       Real Name
61
TimeReport             per event       per endpath-run 
62

    
63
TimeReport ---------- Modules in Path: simulate ---[sec]----
64
TimeReport             per event      per module-visit 
65
TimeReport        CPU       Real        CPU       Real Name
66
TimeReport   0.012248   0.013071   0.012248   0.013071 generator
67
TimeReport   2.677643   2.684026   2.677643   2.684026 geantgen
68
TimeReport   0.101585   0.102749   0.101585   0.102749 photrans
69
TimeReport   1.057789   1.065673   1.057789   1.065673 daq
70
TimeReport   0.000680   0.000621   0.000680   0.000621 rns
71
TimeReport        CPU       Real        CPU       Real Name
72
TimeReport             per event      per module-visit 
73

    
74
TimeReport ------ Modules in End-Path: end_path ---[sec]----
75
TimeReport             per event      per module-visit 
76
TimeReport        CPU       Real        CPU       Real Name
77
TimeReport   0.000200   0.000191   0.000200   0.000191 metadata
78
TimeReport   0.027396   0.027651   0.027396   0.027651 out1
79
TimeReport        CPU       Real        CPU       Real Name
80
TimeReport             per event      per module-visit 
81

    
82
TimeReport ---------- Module Summary ---[sec]----
83
TimeReport             per event        per module-run      per module-visit 
84
TimeReport        CPU       Real        CPU       Real        CPU       Real Name
85
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 daq
86
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 geantgen
87
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 generator
88
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 photrans
89
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 rns
90
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 metadata
91
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 out1
92
TimeReport        CPU       Real        CPU       Real        CPU       Real Name
93
TimeReport             per event        per module-run      per module-visit 
94

    
95
T---Report end!
96

    
97
++ Job ended
98
TimeReport> Time report complete in 860.567 seconds
99
 Time Summary: 
100
 Min: 1.97415
101
 Max: 10.0868
102
 Avg: 4.30284
103

    
104
real time to run through Geant4: 860.67
105
Art has completed and will exit with status 0.
106

    
107

    
108
"Slow":
109

    
110
TrigReport ---------- Event  Summary ------------
111
TrigReport Events total = 200 passed = 200 failed = 0
112

    
113
TrigReport ---------- Path   Summary ------------
114
TrigReport  Trig Bit#        Run     Passed     Failed      Error Name
115
TrigReport     1    0        200        200          0          0 simulate
116

    
117
TrigReport -------End-Path   Summary ------------
118
TrigReport  Trig Bit#        Run     Passed     Failed      Error Name
119
TrigReport     0    0        200        200          0          0 end_path
120

    
121
TrigReport ---------- Modules in Path: simulate ------------
122
TrigReport  Trig Bit#    Visited     Passed     Failed      Error Name
123
TrigReport     1    0        200        200          0          0 generator
124
TrigReport     1    0        200        200          0          0 geantgen
125
TrigReport     1    0        200        200          0          0 photrans
126
TrigReport     1    0        200        200          0          0 daq
127
TrigReport     1    0        200        200          0          0 rns
128

    
129
TrigReport ------ Modules in End-Path: end_path ------------
130
TrigReport  Trig Bit#    Visited     Passed     Failed      Error Name
131
TrigReport     0    0        200        200          0          0 metadata
132
TrigReport     0    0        200        200          0          0 out1
133

    
134
TrigReport ---------- Module Summary ------------
135
TrigReport    Visited        Run     Passed     Failed      Error Name
136
TrigReport        200        200        200          0          0 daq
137
TrigReport        200        200        200          0          0 geantgen
138
TrigReport        200        200        200          0          0 generator
139
TrigReport        200        200        200          0          0 photrans
140
TrigReport        200        200        200          0          0 rns
141
TrigReport        200        200        200          0          0 metadata
142
TrigReport        200        200        200          0          0 out1
143

    
144
TimeReport ---------- Time  Summary ---[sec]----
145
TimeReport CPU = 9805.747495 Real = 9789.651744
146

    
147
TimeReport ---------- Event  Summary ---[sec]----
148
TimeReport CPU/event = 49.028737 Real/event = 48.948259
149

    
150
TimeReport ---------- Path   Summary ---[sec]----
151
TimeReport             per event          per path-run 
152
TimeReport        CPU       Real        CPU       Real Name
153
TimeReport  48.919513  48.998064  48.919513  48.998064 simulate
154
TimeReport        CPU       Real        CPU       Real Name
155
TimeReport             per event          per path-run 
156

    
157
TimeReport -------End-Path   Summary ---[sec]----
158
TimeReport             per event       per endpath-run 
159
TimeReport        CPU       Real        CPU       Real Name
160
TimeReport   0.028246   0.030137   0.028246   0.030137 end_path
161
TimeReport        CPU       Real        CPU       Real Name
162
TimeReport             per event       per endpath-run 
163

    
164
TimeReport ---------- Modules in Path: simulate ---[sec]----
165
TimeReport             per event      per module-visit 
166
TimeReport        CPU       Real        CPU       Real Name
167
TimeReport   0.012598   0.013351   0.012598   0.013351 generator
168
TimeReport  47.816231  47.887490  47.816231  47.887490 geantgen
169
TimeReport   0.098435   0.098889   0.098435   0.098889 photrans
170
TimeReport   0.991649   0.997707   0.991649   0.997707 daq
171
TimeReport   0.000550   0.000582   0.000550   0.000582 rns
172
TimeReport        CPU       Real        CPU       Real Name
173
TimeReport             per event      per module-visit 
174

    
175
TimeReport ------ Modules in End-Path: end_path ---[sec]----
176
TimeReport             per event      per module-visit 
177
TimeReport        CPU       Real        CPU       Real Name
178
TimeReport   0.000150   0.000174   0.000150   0.000174 metadata
179
TimeReport   0.028096   0.029951   0.028096   0.029951 out1
180
TimeReport        CPU       Real        CPU       Real Name
181
TimeReport             per event      per module-visit 
182

    
183
TimeReport ---------- Module Summary ---[sec]----
184
TimeReport             per event        per module-run      per module-visit 
185
TimeReport        CPU       Real        CPU       Real        CPU       Real Name
186
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 daq
187
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 geantgen
188
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 generator
189
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 photrans
190
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 rns
191
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 metadata
192
TimeReport   0.000000   0.000000   0.000000   0.000000   0.000000   0.000000 out1
193
TimeReport        CPU       Real        CPU       Real        CPU       Real Name
194
TimeReport             per event        per module-run      per module-visit 
195

    
196
T---Report end!
197

    
198
++ Job ended
199
TimeReport> Time report complete in 9883.49 seconds
200
 Time Summary: 
201
 Min: 0.25314
202
 Max: 158.694
203
 Avg: 49.4174
204

    
205
real time to run through Geant4: 9883.59
206
Art has completed and will exit with status 0.