Jobsub ID 265893.12@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 265893.12@justin-prod-sched01.dune.hep.ac.uk | |
| Workflow ID | 3543 | |
| Stage ID | 1 | |
| User name | calcuttj@fnal.gov | |
| HTCondor Group | group_dune.prod_mcsim | |
| Requested | Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 18000 (5 hours) | |
| Submitted time | 2024-09-28 14:24:36 | |
| Site | UK_Liverpool | |
| Entry | DUNE_UK_Liverpool_hepgrid5 | |
| Last heartbeat | 2024-09-28 15:46:46 | |
| From worker node | Hostname | r12-n01.ph.liv.ac.uk |
| cpuinfo | AMD EPYC 7453 28-Core Processor | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 259200 (72 hours) | |
| Inner Apptainer? | True | |
| Job state | finished | |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk | |
| Started | 2024-09-28 14:26:13 | |
| Input files | hd-protodune:np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702.hdf5 | |
| Jobscript | Exit code | 0 |
| Real time | 1h (4648s) | |
| CPU time | 57m (3471s = 74%) | |
| Outputting started | 2024-09-28 15:43:43 | |
| Output files | hd-protodune-det-reco:np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup.root hd-protodune-det-reco:np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup_hists.root | |
| Finished | 2024-09-28 15:46:46 | |
| Saved logs | justin-logs:265893.12-justin-prod-sched01.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
ng as is
Retagger: tagging trace set: wiener with 45624 traces, 45624 summary
Retagger: tagging trace set: gauss with 35846 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 35846 traces tagged "gauss"
FrameSaver: q=799718 n=717758 tag=gauss
wclsFrameSaver: saving 45624 traces tagged "wiener"
FrameSaver: q=844782 n=661715 tag=wiener
1100 hits in TPC 0
1812 hits in TPC 1
4029 hits in TPC 2
2820 hits in TPC 3
2642 hits in TPC 4
3898 hits in TPC 5
4817 hits in TPC 6
4964 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 285 XUs and 512 XVs -> 218 XUVs
C:0 T:2 12568 XUs and 9464 XVs -> 378 XUVs
C:0 T:3 219 XUs and 236 XVs -> 9 XUVs
C:0 T:4 32 XUs and 48 XVs -> 1 XUVs
C:0 T:5 12102 XUs and 8335 XVs -> 371 XUVs
C:0 T:6 10375 XUs and 14707 XVs -> 745 XUVs
C:0 T:7 136 XUs and 175 XVs -> 5 XUVs
1727 XUVs total
1139 collection wire objects
1727 potential space points
Neighbour search...
25619 tests to find 15524 neighbours
Iterating with no regularization...
Begin: 4.88927e+06
0 4.66861e+06
1 4.66033e+06
2 4.65946e+06
Now with regularization...
Begin: 4.22899e+06
0 4.2288e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
28-Sep-2024 16:43:33 BST Closed output file "np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup.root"
28-Sep-2024 16:43:33 BST Closed input file "np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 50.2878 72.4518 122.03 71.2304 15.0161 39
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000672544 0.00252705 0.00531617 0.0024396 0.00100068 39
produce:fembfilter:PDHDFEMBFilter 0.462525 0.484943 0.651018 0.480537 0.0283898 39
produce:wclsdatahd:WireCellToolkit 28.0287 30.3803 32.1299 30.2668 0.866849 39
produce:gaushit:GausHitFinder 0.317271 0.470798 0.735139 0.44394 0.105067 39
produce:nhitsfilter:NumberOfHitsFilter 0.000210825 0.000285403 0.000467048 0.000285166 5.05036e-05 39
produce:reco3d:SpacePointSolver 0.148197 1.2736 7.66434 0.440039 1.8704 39
produce:hitpdune:DisambigFromSpacePoints 0.144985 0.365651 1.16478 0.317608 0.214872 39
produce:pandora:StandardPandora 3.19621 9.44388 26.0737 8.47551 4.93185 39
produce:pandoraWriter:StandardPandora 0.063264 0.11055 0.175738 0.107333 0.0265987 39
produce:pandoraTrack:LArPandoraTrackCreation 0.522318 1.20788 3.25846 1.02989 0.59987 39
produce:pandoraShower:LArPandoraShowerCreation 0.460564 1.40957 4.59653 1.163 0.897929 39
produce:pandoracalo:Calorimetry 0.245215 0.569971 1.67867 0.490028 0.280603 39
produce:pandoracalonosce:Calorimetry 0.212632 0.528175 1.63183 0.447555 0.279524 39
produce:pandorapid:Chi2ParticleID 0.00109708 0.0014896 0.00367668 0.00138667 0.000431537 39
produce:pandoraShowercalo:ShowerCalorimetry 0.346312 1.28247 5.1152 1.04442 0.868433 39
produce:pandoraShowercalonosce:ShowerCalorimetry 0.339572 1.25309 4.67635 1.04752 0.801722 39
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0466613 0.0858195 0.136664 0.0859295 0.0203101 39
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0193747 0.0312703 0.0493554 0.0302788 0.00712558 39
produce:emtrkmichelid:EmTrackMichelId 12.7519 22.3051 34.114 22.5683 4.67022 39
[art]:TriggerResults:TriggerResultInserter 1.9838e-05 4.60796e-05 8.4609e-05 4.4804e-05 1.48472e-05 39
end_path:out1:RootOutput 7.865e-06 1.42028e-05 3.6198e-05 1.3475e-05 5.27918e-06 39
end_path:michelremoving:michelremoving 0.0151162 0.0637463 0.204706 0.0386589 0.0471378 39
end_path:michelremovinggnocchi:michelremoving 0.014427 0.0605965 0.204038 0.0354797 0.0462577 39
end_path:calibanagnocchi:CalibAnaTree 0.173453 0.423915 1.12743 0.371397 0.222197 39
end_path:out1:RootOutput(write) 0.307365 0.533365 0.866786 0.519581 0.123928 39
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5037.3 MB
Peak resident set size usage (VmHWM): 2423.26 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup.root
\tHists: np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup.root
Ran successfully
{
"name": "np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup.root",
"namespace": "hd-protodune-det-reco",
"metadata": {
"core.file_format": "artroot",
"core.application.name": "reco",
"core.application.family": "dunesw",
"core.application.version": "v09_91_02d01",
"core.data_tier": "full-reconstructed",
"dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
"dune.campaign": "hd-protodune-reco-keepup-v0",
"core.start_time": 1727535358.0,
"core.end_time": 1727538214.0,
"core.events": [
236,
238,
240,
242,
244,
246,
248,
250,
252,
254,
256,
258,
260,
262,
264,
266,
268,
270,
272,
274,
276,
278,
280,
282,
284,
286,
288,
290,
292,
294,
296,
298,
300,
302,
304,
306,
308,
310,
312
],
"core.event_count": 39,
"core.first_event_number": 236,
"core.last_event_number": 312,
"core.data_stream": "cosmics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
29386
],
"core.runs_subruns": [
2938600001
],
"dune.daq_test": false,
"retention.status": "active",
"retention.class": "physics",
"origin.applications.config_files": {
"reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
},
"origin.applications.versions": {
"reco1": "v09_91_02d01"
},
"origin.applications.names": [
"reco1"
]
},
"parents": [
{
"did": "hd-protodune:np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702_reco_stage1_reco_stage2_20240928T154333_keepup_hists.root",
"namespace": "hd-protodune-det-reco",
"metadata": {
"core.file_format": "root",
"core.application.name": "reco",
"core.application.family": "dunesw",
"core.application.version": "v09_91_02d01",
"core.data_tier": "root-tuple-virtual",
"dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
"dune.campaign": "hd-protodune-reco-keepup-v0",
"core.start_time": 1727535358.0,
"core.end_time": 1727538214.0,
"core.data_stream": "cosmics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
29386
],
"core.runs_subruns": [
2938600001
],
"dune.daq_test": false,
"retention.status": "active",
"retention.class": "physics",
"origin.applications.config_files": {
"reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
},
"origin.applications.versions": {
"reco1": "v09_91_02d01"
},
"origin.applications.names": [
"reco1"
]
},
"parents": [
{
"did": "hd-protodune:np04hd_raw_run029386_0003_dataflow0_datawriter_0_20240928T131702.hdf5"
}
]
}