Jobsub ID 79952.126@justin-prod-sched02.dune.hep.ac.uk
| Jobsub ID | 79952.126@justin-prod-sched02.dune.hep.ac.uk | |
| Workflow ID | 3512 | |
| 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:07:38 | |
| Site | CA_SFU | |
| Entry | DUNE_CA_SFU_lcg-ce3 | |
| Last heartbeat | 2024-09-27 15:51:00 | |
| From worker node | Hostname | cdr167.int.cedar.computecanada.ca |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2683 v4 @ 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:17:41 | |
| Input files | hd-protodune:np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548.hdf5 | |
| Jobscript | Exit code | 0 |
| Real time | 1h (6807s) | |
| CPU time | 1h (4947s = 72%) | |
| Outputting started | 2024-09-27 15:11:10 | |
| Output files | hd-protodune-det-reco:np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_keepup.root hd-protodune-det-reco:np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_keepup_hists.root | |
| Finished | 2024-09-27 15:51:00 | |
| Saved logs | justin-logs:79952.126-justin-prod-sched02.dune.hep.ac.uk.logs.tgz | |
| List job events Wrapper job log | ||
Jobscript log (last 10,000 characters)
ts
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 22507 traces, 22507 summary
Retagger: tagging trace set: gauss with 17182 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 17182 traces tagged "gauss"
FrameSaver: q=525436 n=291392 tag=gauss
wclsFrameSaver: saving 22507 traces tagged "wiener"
FrameSaver: q=563001 n=257690 tag=wiener
835 hits in TPC 0
1171 hits in TPC 1
3163 hits in TPC 2
2252 hits in TPC 3
800 hits in TPC 4
1536 hits in TPC 5
1385 hits in TPC 6
867 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 190 XUs and 187 XVs -> 11 XUVs
C:0 T:2 8874 XUs and 5339 XVs -> 197 XUVs
C:0 T:3 95 XUs and 146 XVs -> 9 XUVs
C:0 T:4 21 XUs and 18 XVs -> 0 XUVs
C:0 T:5 760 XUs and 967 XVs -> 73 XUVs
C:0 T:6 4081 XUs and 873 XVs -> 33 XUVs
C:0 T:7 42 XUs and 25 XVs -> 10 XUVs
333 XUVs total
244 collection wire objects
333 potential space points
Neighbour search...
2667 tests to find 1500 neighbours
Iterating with no regularization...
Begin: 4.36819e+06
0 4.282e+06
1 4.27392e+06
2 4.27364e+06
Now with regularization...
Begin: 3.96636e+06
0 3.96627e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
27-Sep-2024 08:11:00 PDT Closed output file "np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_keepup.root"
27-Sep-2024 08:11:00 PDT Closed input file "np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 59.5267 111.757 167.207 110.693 20.82 35
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000739104 0.00248347 0.00873775 0.00204126 0.00158295 35
produce:fembfilter:PDHDFEMBFilter 0.74221 0.759047 0.827668 0.753235 0.0156093 35
produce:wclsdatahd:WireCellToolkit 44.4188 46.7397 50.5251 46.4913 1.56422 35
produce:gaushit:GausHitFinder 0.26657 0.873501 1.4551 0.85484 0.234356 35
produce:nhitsfilter:NumberOfHitsFilter 0.000165168 0.000382694 0.000974318 0.000361062 0.000152268 35
produce:reco3d:SpacePointSolver 0.0693469 0.973287 3.37491 0.734438 0.725743 35
produce:hitpdune:DisambigFromSpacePoints 0.065742 0.690683 1.54515 0.73587 0.335951 35
produce:pandora:StandardPandora 2.78986 20.0825 38.0861 20.3224 8.3328 35
produce:pandoraWriter:StandardPandora 0.053308 0.172112 0.262709 0.178274 0.0399303 35
produce:pandoraTrack:LArPandoraTrackCreation 0.297714 2.24265 5.02177 1.99978 1.02631 35
produce:pandoraShower:LArPandoraShowerCreation 0.138807 2.59978 8.06324 2.18311 1.4959 35
produce:pandoracalo:Calorimetry 0.143658 0.999142 2.19404 0.933515 0.419822 35
produce:pandoracalonosce:Calorimetry 0.126693 0.949666 2.07204 0.873192 0.425102 35
produce:pandorapid:Chi2ParticleID 0.00114944 0.00209638 0.00322783 0.00206682 0.000461537 35
produce:pandoraShowercalo:ShowerCalorimetry 0.119591 2.26429 6.51173 1.93963 1.24168 35
produce:pandoraShowercalonosce:ShowerCalorimetry 0.11783 2.21682 6.01507 2.0067 1.14084 35
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0413627 0.136028 0.196096 0.141914 0.0301722 35
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0157899 0.0512139 0.0753852 0.0500897 0.0132051 35
produce:emtrkmichelid:EmTrackMichelId 9.61947 28.1658 39.5758 29.4241 6.40413 35
[art]:TriggerResults:TriggerResultInserter 2.4029e-05 3.85179e-05 0.00011142 2.9613e-05 2.12305e-05 35
end_path:out1:RootOutput 9.645e-06 1.23513e-05 2.461e-05 1.1066e-05 3.35414e-06 35
end_path:michelremoving:michelremoving 0.012753 0.0792167 0.42858 0.0481166 0.0787392 35
end_path:michelremovinggnocchi:michelremoving 0.0130844 0.0794586 0.424973 0.0481971 0.0777342 35
end_path:calibanagnocchi:CalibAnaTree 0.118953 0.734482 1.66086 0.658055 0.305571 35
end_path:out1:RootOutput(write) 0.262883 0.83043 1.22647 0.8492 0.19537 35
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4975.71 MB
Peak resident set size usage (VmHWM): 2649.42 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_keepup.root
\tHists: np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_keepup.root
Ran successfully
{
"name": "np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_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": 1727445892.0,
"core.end_time": 1727449861.0,
"core.events": [
4903,
4907,
4911,
4915,
4919,
4923,
4927,
4931,
4935,
4939,
4943,
4947,
4951,
4955,
4959,
4963,
4967,
4971,
4975,
4979,
4983,
4987,
4991,
4995,
4999,
5003,
5007,
5011,
5015,
5019,
5023,
5027,
5031,
5035,
5039
],
"core.event_count": 35,
"core.first_event_number": 4903,
"core.last_event_number": 5039,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27347
],
"core.runs_subruns": [
2734700001
],
"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_run027347_0035_dataflow3_datawriter_0_20240621T161548.hdf5"
}
]
}Forming hist metadata
formed
{
"name": "np04hd_raw_run027347_0035_dataflow3_datawriter_0_20240621T161548_reco_stage1_reco_stage2_20240927T151100_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": 1727445892.0,
"core.end_time": 1727449861.0,
"core.data_stream": "physics",
"core.file_content_status": "good",
"core.file_type": "detector",
"core.run_type": "hd-protodune",
"core.runs": [
27347
],
"core.runs_subruns": [
2734700001
],
"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_run027347_0035_dataflow3_datawriter_0_20240621T161548.hdf5"
}
]
}