Jobsub ID 264724.112@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 264724.112@justin-prod-sched01.dune.hep.ac.uk | |
| Workflow ID | 3517 | |
| 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 07:14:59 | |
| Site | US_Wisconsin | |
| Entry | HCCHTPC_US_Wisconsin_osg01_rhel7 | |
| Last heartbeat | 2024-09-27 11:51:51 | |
| From worker node | Hostname | herringa2001 |
| cpuinfo | AMD EPYC 7763 64-Core Processor | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 82800 (23 hours) | |
| Inner Apptainer? | True | |
| Job state | finished | |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk | |
| Started | 2024-09-27 08:35:42 | |
| Input files | hd-protodune:np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617.hdf5 | |
| Jobscript | Exit code | 0 |
| Real time | 3h (11630s) | |
| CPU time | 1h (5090s = 43%) | |
| Outputting started | 2024-09-27 11:49:33 | |
| Output files | hd-protodune-det-reco:np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_keepup.root hd-protodune-det-reco:np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_keepup_hists.root | |
| Finished | 2024-09-27 11:51:51 | |
| Saved logs | justin-logs:264724.112-justin-prod-sched01.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
sFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 36000 traces tagged "gauss"
FrameSaver: q=1.16235e+06 n=672810 tag=gauss
wclsFrameSaver: saving 47199 traces tagged "wiener"
FrameSaver: q=1.2541e+06 n=609646 tag=wiener
3119 hits in TPC 0
3339 hits in TPC 1
3408 hits in TPC 2
3003 hits in TPC 3
1968 hits in TPC 4
6236 hits in TPC 5
5168 hits in TPC 6
3886 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1961 XUs and 1760 XVs -> 55 XUVs
C:0 T:2 6524 XUs and 7554 XVs -> 267 XUVs
C:0 T:3 900 XUs and 902 XVs -> 76 XUVs
C:0 T:4 324 XUs and 396 XVs -> 18 XUVs
C:0 T:5 16992 XUs and 21968 XVs -> 609 XUVs
C:0 T:6 13845 XUs and 17146 XVs -> 521 XUVs
C:0 T:7 24032 XUs and 22437 XVs -> 2879 XUVs
4425 XUVs total
1068 collection wire objects
4425 potential space points
Neighbour search...
384085 tests to find 171232 neighbours
Iterating with no regularization...
Begin: 8.3523e+06
0 7.44609e+06
1 7.3754e+06
2 7.36162e+06
3 7.3566e+06
Now with regularization...
Begin: 6.75188e+06
0 6.74825e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
27-Sep-2024 06:49:04 CDT Closed output file "np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_keepup.root"
27-Sep-2024 06:49:05 CDT Closed input file "np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 75.6995 118.171 178.995 115.595 22.5544 35
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000794642 0.00256297 0.00788276 0.00241276 0.00152752 35
produce:fembfilter:PDHDFEMBFilter 0.699976 0.93752 1.05285 0.984978 0.0990802 35
produce:wclsdatahd:WireCellToolkit 41.1969 47.2692 51.2338 47.4456 2.22353 35
produce:gaushit:GausHitFinder 0.408531 0.986101 1.64889 0.998338 0.246844 35
produce:nhitsfilter:NumberOfHitsFilter 0.000253576 0.000436762 0.000696838 0.000430759 8.87439e-05 35
produce:reco3d:SpacePointSolver 0.192683 1.36667 4.05663 1.11519 0.953447 35
produce:hitpdune:DisambigFromSpacePoints 0.172469 0.835555 1.96466 0.729873 0.381311 35
produce:pandora:StandardPandora 5.30086 18.5494 50.5539 17.287 8.56124 35
produce:pandoraWriter:StandardPandora 0.104345 0.197608 0.280184 0.19671 0.0442972 35
produce:pandoraTrack:LArPandoraTrackCreation 0.646243 1.77691 3.19122 1.68054 0.674519 35
produce:pandoraShower:LArPandoraShowerCreation 0.568198 2.11765 5.27652 1.91579 1.03634 35
produce:pandoracalo:Calorimetry 0.364278 0.944742 1.54817 0.925734 0.317752 35
produce:pandoracalonosce:Calorimetry 0.316501 0.863864 1.42624 0.82377 0.295805 35
produce:pandorapid:Chi2ParticleID 0.00169798 0.00269888 0.00470236 0.00257355 0.000554243 35
produce:pandoraShowercalo:ShowerCalorimetry 0.493127 1.93066 3.91643 1.80894 0.855223 35
produce:pandoraShowercalonosce:ShowerCalorimetry 0.474696 1.83499 3.63612 1.82118 0.794749 35
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.107103 0.194852 0.302225 0.195048 0.0499133 35
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0351741 0.0645362 0.0961174 0.0666176 0.0157214 35
produce:emtrkmichelid:EmTrackMichelId 16.9726 36.3499 55.4541 36.1474 8.48759 35
[art]:TriggerResults:TriggerResultInserter 2.2912e-05 4.73563e-05 0.000122841 3.7691e-05 2.21726e-05 35
end_path:out1:RootOutput 1.0139e-05 1.68955e-05 5.1216e-05 1.4417e-05 7.85279e-06 35
end_path:michelremoving:michelremoving 0.0210609 0.091275 0.406859 0.0416174 0.0924318 35
end_path:michelremovinggnocchi:michelremoving 0.0188743 0.0871119 0.39942 0.0368096 0.0908187 35
end_path:calibanagnocchi:CalibAnaTree 0.230172 0.645537 1.22577 0.587712 0.223616 35
end_path:out1:RootOutput(write) 0.530255 0.980867 1.50023 0.979921 0.243853 35
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4999.03 MB
Peak resident set size usage (VmHWM): 2654.97 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_keepup.root
\tHists: np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_keepup.root
Ran successfully
{
"name": "np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_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": 1727433551.0,
"core.end_time": 1727437746.0,
"core.events": [
91703,
91707,
91711,
91715,
91719,
91723,
91727,
91731,
91735,
91739,
91743,
91747,
91751,
91755,
91759,
91763,
91767,
91771,
91775,
91779,
91783,
91787,
91791,
91795,
91799,
91803,
91807,
91811,
91815,
91819,
91823,
91827,
91831,
91835,
91839
],
"core.event_count": 35,
"core.first_event_number": 91703,
"core.last_event_number": 91839,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27398
],
"core.runs_subruns": [
2739800001
],
"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_run027398_0655_dataflow3_datawriter_0_20240624T045617.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np04hd_raw_run027398_0655_dataflow3_datawriter_0_20240624T045617_reco_stage1_reco_stage2_20240927T114904_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": 1727433551.0,
"core.end_time": 1727437746.0,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27398
],
"core.runs_subruns": [
2739800001
],
"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_run027398_0655_dataflow3_datawriter_0_20240624T045617.hdf5"
}
]
}