Jobsub ID 269431.2@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 269431.2@justin-prod-sched01.dune.hep.ac.uk | |
| Workflow ID | 3568 | |
| 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-10-04 18:10:45 | |
| Site | US_UChicago | |
| Entry | Engage_US_MWT2_iut2_condce_mcore | |
| Last heartbeat | 2024-10-05 02:03:05 | |
| From worker node | Hostname | mwt2-c039.campuscluster.illinois.edu |
| cpuinfo | AMD EPYC 7443 24-Core Processor | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 86400 (24 hours) | |
| Inner Apptainer? | True | |
| Job state | finished | |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk | |
| Started | 2024-10-05 00:57:34 | |
| Input files | hd-protodune:np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432.hdf5 | |
| Jobscript | Exit code | 0 |
| Real time | 1h (3905s) | |
| CPU time | 47m (2855s = 73%) | |
| Outputting started | 2024-10-05 02:02:40 | |
| Output files | hd-protodune-det-reco:np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_keepup.root hd-protodune-det-reco:np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_keepup_hists.root | |
| Finished | 2024-10-05 02:03:05 | |
| Saved logs | justin-logs:269431.2-justin-prod-sched01.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
traces tagged "wiener"
FrameSaver: q=2.05675e+06 n=830760 tag=wiener
3314 hits in TPC 0
4000 hits in TPC 1
7628 hits in TPC 2
4559 hits in TPC 3
2770 hits in TPC 4
4830 hits in TPC 5
7850 hits in TPC 6
5228 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 8440 XUs and 3171 XVs -> 119 XUVs
C:0 T:2 27299 XUs and 18040 XVs -> 406 XUVs
C:0 T:3 340 XUs and 404 XVs -> 18 XUVs
C:0 T:4 613 XUs and 572 XVs -> 12 XUVs
C:0 T:5 23310 XUs and 11354 XVs -> 402 XUVs
C:0 T:6 22866 XUs and 26345 XVs -> 885 XUVs
C:0 T:7 849 XUs and 932 XVs -> 26 XUVs
1868 XUVs total
1204 collection wire objects
1868 potential space points
Neighbour search...
33340 tests to find 21272 neighbours
Iterating with no regularization...
Begin: 1.8394e+07
0 1.77065e+07
1 1.76834e+07
2 1.76809e+07
Now with regularization...
Begin: 1.67789e+07
0 1.67777e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
04-Oct-2024 21:02:35 CDT Closed output file "np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_keepup.root"
04-Oct-2024 21:02:35 CDT Closed input file "np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 36.767 57.0763 80.0537 55.6808 9.11912 40
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000249007 0.000981054 0.00183969 0.000974995 0.000473101 40
produce:fembfilter:PDHDFEMBFilter 0.423609 0.452588 0.46827 0.456597 0.0110888 40
produce:wclsdatahd:WireCellToolkit 23.5997 24.8296 26.6116 24.9654 0.697324 40
produce:gaushit:GausHitFinder 0.189769 0.39287 0.621476 0.382324 0.0888455 40
produce:nhitsfilter:NumberOfHitsFilter 9.9176e-05 0.000219056 0.000511471 0.000197721 8.16468e-05 40
produce:reco3d:SpacePointSolver 0.0744694 0.401499 1.19526 0.356598 0.248825 40
produce:hitpdune:DisambigFromSpacePoints 0.0808816 0.29207 0.589688 0.26981 0.121464 40
produce:pandora:StandardPandora 1.91807 7.56753 27.4237 6.64931 4.14485 40
produce:pandoraWriter:StandardPandora 0.0327662 0.0728442 0.149087 0.0691223 0.0223268 40
produce:pandoraTrack:LArPandoraTrackCreation 0.242329 0.67494 1.19488 0.671296 0.198646 40
produce:pandoraShower:LArPandoraShowerCreation 0.227567 0.859786 1.69704 0.813231 0.335869 40
produce:pandoracalo:Calorimetry 0.140056 0.384354 0.649105 0.392115 0.110628 40
produce:pandoracalonosce:Calorimetry 0.125403 0.358167 0.617409 0.350722 0.107117 40
produce:pandorapid:Chi2ParticleID 0.000606218 0.00107946 0.00307404 0.00103985 0.000380772 40
produce:pandoraShowercalo:ShowerCalorimetry 0.201779 0.878136 1.67814 0.824539 0.345344 40
produce:pandoraShowercalonosce:ShowerCalorimetry 0.198208 0.83392 1.58401 0.787784 0.324281 40
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0284326 0.0647882 0.0895929 0.0643683 0.0143709 40
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0102307 0.0224401 0.0445469 0.0220506 0.00588516 40
produce:emtrkmichelid:EmTrackMichelId 8.5154 18.1254 25.4926 17.748 3.70073 40
[art]:TriggerResults:TriggerResultInserter 1.1973e-05 1.65785e-05 9.2655e-05 1.4607e-05 1.23217e-05 40
end_path:out1:RootOutput 2.725e-06 5.86847e-06 2.4706e-05 5.34e-06 3.14801e-06 40
end_path:michelremoving:michelremoving 0.00799511 0.0354442 0.207007 0.016934 0.0380696 40
end_path:michelremovinggnocchi:michelremoving 0.00741813 0.0338773 0.20528 0.0153093 0.0381241 40
end_path:calibanagnocchi:CalibAnaTree 0.101642 0.293301 0.503393 0.305592 0.0901424 40
end_path:out1:RootOutput(write) 0.20759 0.439988 0.623237 0.432856 0.0902925 40
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5022.96 MB
Peak resident set size usage (VmHWM): 2401.3 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_keepup.root
\tHists: np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_keepup.root
Ran successfully
{
"name": "np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_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": 1728091450.0,
"core.end_time": 1728093756.0,
"core.events": [
1441,
1442,
1443,
1444,
1445,
1446,
1447,
1448,
1449,
1450,
1451,
1452,
1453,
1454,
1455,
1456,
1457,
1458,
1459,
1460,
1461,
1462,
1463,
1464,
1465,
1466,
1467,
1468,
1469,
1470,
1471,
1472,
1473,
1474,
1475,
1476,
1477,
1478,
1479,
1480
],
"core.event_count": 40,
"core.first_event_number": 1441,
"core.last_event_number": 1480,
"core.data_stream": "cosmics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27447
],
"core.runs_subruns": [
2744700001
],
"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_run027447_0036_dataflow0_datawriter_0_20240626T185432.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np04hd_raw_run027447_0036_dataflow0_datawriter_0_20240626T185432_reco_stage1_reco_stage2_20241005T020235_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": 1728091450.0,
"core.end_time": 1728093756.0,
"core.data_stream": "cosmics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27447
],
"core.runs_subruns": [
2744700001
],
"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_run027447_0036_dataflow0_datawriter_0_20240626T185432.hdf5"
}
]
}