Jobsub ID 79965.129@justin-prod-sched02.dune.hep.ac.uk
| Jobsub ID | 79965.129@justin-prod-sched02.dune.hep.ac.uk | |
| Workflow ID | 3511 | |
| 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-27 08:20:21 | |
| Site | CA_SFU | |
| Entry | DUNE_CA_SFU_lcg-ce3 | |
| Last heartbeat | 2024-09-27 16:45:16 | |
| From worker node | Hostname | cdr1245.int.cedar.computecanada.ca |
| cpuinfo | Intel(R) Xeon(R) Platinum 8160 CPU @ 2.10GHz | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 84598 (23 hours) | |
| Inner Apptainer? | True | |
| Job state | finished | |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk | |
| Started | 2024-09-27 13:35:41 | |
| Input files | hd-protodune:np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617.hdf5 | |
| Jobscript | Exit code | 0 |
| Real time | 2h (8899s) | |
| CPU time | 1h (6949s = 78%) | |
| Outputting started | 2024-09-27 16:04:03 | |
| Output files | hd-protodune-det-reco:np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_keepup.root hd-protodune-det-reco:np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_keepup_hists.root | |
| Finished | 2024-09-27 16:45:16 | |
| Saved logs | justin-logs:79965.129-justin-prod-sched02.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
race set: gauss with 54295 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 54295 traces tagged "gauss"
FrameSaver: q=1.95194e+06 n=913624 tag=gauss
wclsFrameSaver: saving 76208 traces tagged "wiener"
FrameSaver: q=2.17946e+06 n=817922 tag=wiener
5042 hits in TPC 0
5624 hits in TPC 1
8205 hits in TPC 2
4597 hits in TPC 3
2810 hits in TPC 4
3032 hits in TPC 5
7028 hits in TPC 6
5301 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 17284 XUs and 11784 XVs -> 1271 XUVs
C:0 T:2 61451 XUs and 82128 XVs -> 2547 XUVs
C:0 T:3 203 XUs and 99 XVs -> 1 XUVs
C:0 T:4 163 XUs and 224 XVs -> 14 XUVs
C:0 T:5 8629 XUs and 6664 XVs -> 282 XUVs
C:0 T:6 48957 XUs and 45027 XVs -> 1236 XUVs
C:0 T:7 846 XUs and 1202 XVs -> 23 XUVs
5374 XUVs total
1646 collection wire objects
5374 potential space points
Neighbour search...
464734 tests to find 220206 neighbours
Iterating with no regularization...
Begin: 4.69709e+07
0 4.32099e+07
1 4.29592e+07
2 4.29314e+07
Now with regularization...
Begin: 4.16858e+07
0 4.16744e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
27-Sep-2024 09:03:54 PDT Closed output file "np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_keepup.root"
27-Sep-2024 09:03:54 PDT Closed input file "np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 104.707 164.927 553.984 133.311 89.1715 35
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000478779 0.00236954 0.00565982 0.00174618 0.00145787 35
produce:fembfilter:PDHDFEMBFilter 0.974426 0.99138 1.02225 0.990522 0.00786155 35
produce:wclsdatahd:WireCellToolkit 53.9669 55.5195 60.3495 55.2841 1.14065 35
produce:gaushit:GausHitFinder 0.873396 1.24677 2.27086 1.20163 0.286432 35
produce:nhitsfilter:NumberOfHitsFilter 0.000391098 0.000519829 0.000807012 0.000507016 9.65083e-05 35
produce:reco3d:SpacePointSolver 0.618157 1.88291 4.68852 1.60367 1.01613 35
produce:hitpdune:DisambigFromSpacePoints 0.558854 1.32066 3.69001 1.16013 0.628361 35
produce:pandora:StandardPandora 13.5355 56.4384 373.075 32.783 73.2368 35
produce:pandoraWriter:StandardPandora 0.165935 0.227937 0.411984 0.212093 0.0548032 35
produce:pandoraTrack:LArPandoraTrackCreation 1.44185 3.13952 11.8505 2.49344 2.02881 35
produce:pandoraShower:LArPandoraShowerCreation 1.32193 3.19178 9.52506 2.57925 1.69732 35
produce:pandoracalo:Calorimetry 0.73953 1.47995 5.31301 1.17149 0.921834 35
produce:pandoracalonosce:Calorimetry 0.683657 1.39754 5.04871 1.11236 0.889417 35
produce:pandorapid:Chi2ParticleID 0.0019642 0.00284219 0.00540034 0.00270458 0.000688635 35
produce:pandoraShowercalo:ShowerCalorimetry 1.23418 2.88327 8.59924 2.31888 1.59143 35
produce:pandoraShowercalonosce:ShowerCalorimetry 1.18131 2.76861 8.17119 2.18985 1.52032 35
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.122386 0.179747 0.306325 0.171594 0.0407132 35
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0436149 0.0661008 0.111098 0.0645943 0.0147977 35
produce:emtrkmichelid:EmTrackMichelId 21.6751 29.4321 52.9154 27.1816 6.56781 35
[art]:TriggerResults:TriggerResultInserter 2.7319e-05 3.69246e-05 9.2008e-05 3.5902e-05 1.08248e-05 35
end_path:out1:RootOutput 1.0274e-05 1.27577e-05 2.6863e-05 1.2401e-05 2.52664e-06 35
end_path:michelremoving:michelremoving 0.0268721 0.0817425 0.268595 0.0452483 0.0720213 35
end_path:michelremovinggnocchi:michelremoving 0.0243018 0.0762391 0.264701 0.0384898 0.0728182 35
end_path:calibanagnocchi:CalibAnaTree 0.54982 1.16976 4.07586 0.966073 0.728665 35
end_path:out1:RootOutput(write) 0.930087 1.2953 2.36327 1.20468 0.303405 35
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5034.76 MB
Peak resident set size usage (VmHWM): 2718.19 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_keepup.root
\tHists: np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_keepup.root
Ran successfully
{
"name": "np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_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": 1727447216.0,
"core.end_time": 1727453034.0,
"core.events": [
9244,
9248,
9252,
9256,
9260,
9264,
9268,
9272,
9276,
9280,
9284,
9288,
9292,
9296,
9300,
9304,
9308,
9312,
9316,
9320,
9324,
9328,
9332,
9336,
9340,
9344,
9348,
9352,
9356,
9360,
9364,
9368,
9372,
9376,
9380
],
"core.event_count": 35,
"core.first_event_number": 9244,
"core.last_event_number": 9380,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27334
],
"core.runs_subruns": [
2733400001
],
"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_run027334_0066_dataflow0_datawriter_0_20240621T034617.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np04hd_raw_run027334_0066_dataflow0_datawriter_0_20240621T034617_reco_stage1_reco_stage2_20240927T160354_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": 1727447216.0,
"core.end_time": 1727453034.0,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27334
],
"core.runs_subruns": [
2733400001
],
"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_run027334_0066_dataflow0_datawriter_0_20240621T034617.hdf5"
}
]
}