Jobsub ID 264819.176@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 264819.176@justin-prod-sched01.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:43:44 | |
| Site | US_FNAL-T1 | |
| Entry | CMSHTPC_T1_US_FNAL_condce_opp1_whole | |
| Last heartbeat | 2024-09-27 13:25:17 | |
| From worker node | Hostname | dunegli-35088-0-cmswn2324.fnal.gov |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2670 v3 @ 2.30GHz | |
| OS release | Scientific Linux release 7.9 (Nitrogen) | |
| Processors | 1 | |
| RSS bytes | 4193255424 (3999 MiB) | |
| Wall seconds limit | 171000 (47 hours) | |
| Inner Apptainer? | True | |
| Job state | finished | |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk | |
| Started | 2024-09-27 09:44:35 | |
| Input files | hd-protodune:np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120.hdf5 | |
| Jobscript | Exit code | 0 |
| Real time | 3h (13123s) | |
| CPU time | 2h (7339s = 55%) | |
| Outputting started | 2024-09-27 13:23:19 | |
| Output files | hd-protodune-det-reco:np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_keepup.root hd-protodune-det-reco:np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_keepup_hists.root | |
| Finished | 2024-09-27 13:25:17 | |
| Saved logs | justin-logs:264819.176-justin-prod-sched01.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
67408 traces, 67408 summary
Retagger: tagging trace set: gauss with 50291 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 50291 traces tagged "gauss"
FrameSaver: q=1.82399e+06 n=911555 tag=gauss
wclsFrameSaver: saving 67408 traces tagged "wiener"
FrameSaver: q=1.97201e+06 n=818483 tag=wiener
4092 hits in TPC 0
4385 hits in TPC 1
5046 hits in TPC 2
1972 hits in TPC 3
3407 hits in TPC 4
7574 hits in TPC 5
8173 hits in TPC 6
3034 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2404 XUs and 3963 XVs -> 250 XUVs
C:0 T:2 17580 XUs and 13019 XVs -> 327 XUVs
C:0 T:3 77 XUs and 102 XVs -> 3 XUVs
C:0 T:4 210 XUs and 264 XVs -> 19 XUVs
C:0 T:5 19168 XUs and 22924 XVs -> 987 XUVs
C:0 T:6 55382 XUs and 40706 XVs -> 1571 XUVs
C:0 T:7 468 XUs and 409 XVs -> 18 XUVs
3175 XUVs total
1529 collection wire objects
3175 potential space points
Neighbour search...
120503 tests to find 49844 neighbours
Iterating with no regularization...
Begin: 2.7471e+07
0 2.49053e+07
1 2.47309e+07
2 2.47123e+07
Now with regularization...
Begin: 2.34284e+07
0 2.34218e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
27-Sep-2024 13:22:41 UTC Closed output file "np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_keepup.root"
27-Sep-2024 13:22:41 UTC Closed input file "np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 101.302 180.465 302.5 163.098 56.9004 35
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000682935 0.0119857 0.315633 0.00277436 0.0521129 35
produce:fembfilter:PDHDFEMBFilter 0.838185 1.20464 2.47293 1.14279 0.307767 35
produce:wclsdatahd:WireCellToolkit 45.1478 55.1286 70.6509 54.1677 8.29228 35
produce:gaushit:GausHitFinder 0.537612 1.17869 1.71961 1.17848 0.291438 35
produce:nhitsfilter:NumberOfHitsFilter 0.000294845 0.000500227 0.000695596 0.000492033 9.78226e-05 35
produce:reco3d:SpacePointSolver 0.247104 1.82576 4.29816 1.63709 0.987366 35
produce:hitpdune:DisambigFromSpacePoints 0.203874 1.2458 3.21627 0.983278 0.720219 35
produce:pandora:StandardPandora 8.68461 56.3313 163.707 43.859 36.6834 35
produce:pandoraWriter:StandardPandora 0.132089 0.234253 0.360942 0.223774 0.0566357 35
produce:pandoraTrack:LArPandoraTrackCreation 1.19045 4.84493 9.92078 4.01669 2.72609 35
produce:pandoraShower:LArPandoraShowerCreation 0.567613 4.96187 12.8185 3.736 3.32849 35
produce:pandoracalo:Calorimetry 0.542329 2.10844 4.7739 1.68379 1.16092 35
produce:pandoracalonosce:Calorimetry 0.506988 2.00909 4.9356 1.60798 1.14744 35
produce:pandorapid:Chi2ParticleID 0.00153889 0.00300793 0.00471335 0.00284867 0.000795128 35
produce:pandoraShowercalo:ShowerCalorimetry 0.50186 4.19635 11.2289 3.39193 2.74123 35
produce:pandoraShowercalonosce:ShowerCalorimetry 0.491756 3.9295 10.9148 3.34127 2.54175 35
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0778002 0.171054 0.283179 0.158797 0.0449 35
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0274206 0.0607749 0.106221 0.0585628 0.0171209 35
produce:emtrkmichelid:EmTrackMichelId 20.6123 37.9103 61.192 37.1993 9.38104 35
[art]:TriggerResults:TriggerResultInserter 2.7289e-05 5.12104e-05 0.00010212 5.0255e-05 1.40559e-05 35
end_path:out1:RootOutput 7.811e-06 1.32904e-05 5.1984e-05 1.0744e-05 7.75433e-06 35
end_path:michelremoving:michelremoving 0.0231269 0.105088 0.291264 0.0549635 0.0847375 35
end_path:michelremovinggnocchi:michelremoving 0.0220043 0.100025 0.298715 0.0499604 0.0833996 35
end_path:calibanagnocchi:CalibAnaTree 0.353757 1.62898 4.06756 1.25557 0.944628 35
end_path:out1:RootOutput(write) 0.536624 1.09227 1.70255 1.01453 0.276912 35
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5070.47 MB
Peak resident set size usage (VmHWM): 2727.13 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_keepup.root
\tHists: np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_keepup.root
Ran successfully
{
"name": "np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_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": 1727436992.0,
"core.end_time": 1727443362.0,
"core.events": [
38503,
38507,
38511,
38515,
38519,
38523,
38527,
38531,
38535,
38539,
38543,
38547,
38551,
38555,
38559,
38563,
38567,
38571,
38575,
38579,
38583,
38587,
38591,
38595,
38599,
38603,
38607,
38611,
38615,
38619,
38623,
38627,
38631,
38635,
38639
],
"core.event_count": 35,
"core.first_event_number": 38503,
"core.last_event_number": 38639,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27332
],
"core.runs_subruns": [
2733200001
],
"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_run027332_0275_dataflow3_datawriter_0_20240621T001120.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np04hd_raw_run027332_0275_dataflow3_datawriter_0_20240621T001120_reco_stage1_reco_stage2_20240927T132241_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": 1727436992.0,
"core.end_time": 1727443362.0,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27332
],
"core.runs_subruns": [
2733200001
],
"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_run027332_0275_dataflow3_datawriter_0_20240621T001120.hdf5"
}
]
}