Jobsub ID 263763.135@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 263763.135@justin-prod-sched01.dune.hep.ac.uk |
Workflow ID | 3448 |
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-26 13:24:49 |
Site | UK_Sheffield |
Entry | DUNE_UK_Sheffield_lcgce1 |
Last heartbeat | 2024-09-26 14:51:56 |
From worker node | Hostname | wn082.hep |
cpuinfo | Intel(R) Xeon(R) CPU E5-2650 v2 @ 2.60GHz |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 4193255424 (3999 MiB) |
Wall seconds limit | 257400 (71 hours) |
Inner Apptainer? | True |
Job state | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 13:26:16 |
Input files | hd-protodune:np04hd_raw_run029094_0071_dataflow3_datawriter_0_20240906T090751.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 14:51:56 |
Saved logs | justin-logs:263763.135-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
42625 traces tagged "wiener"
FrameSaver: q=693866 n=490739 tag=wiener
1934 hits in TPC 0
1435 hits in TPC 1
6226 hits in TPC 2
4137 hits in TPC 3
1285 hits in TPC 4
3303 hits in TPC 5
2029 hits in TPC 6
894 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 7 XUs and 5 XVs -> 2 XUVs
C:0 T:1 118 XUs and 381 XVs -> 4 XUVs
C:0 T:2 18982 XUs and 17532 XVs -> 470 XUVs
C:0 T:3 1042 XUs and 1386 XVs -> 20 XUVs
C:0 T:4 41 XUs and 67 XVs -> 3 XUVs
C:0 T:5 5487 XUs and 4837 XVs -> 209 XUVs
C:0 T:6 2893 XUs and 2227 XVs -> 26 XUVs
C:0 T:7 12 XUs and 15 XVs -> 0 XUVs
734 XUVs total
506 collection wire objects
734 potential space points
Neighbour search...
6138 tests to find 3380 neighbours
Iterating with no regularization...
Begin: 4.59494e+06
0 4.50996e+06
1 4.50823e+06
Now with regularization...
Begin: 4.26052e+06
0 4.26023e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29094 subRun: 1 event: 17267 at 26-Sep-2024 15:48:05 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 41192 traces, 41192 summary
Retagger: tagging trace set: gauss with 32326 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 32326 traces tagged "gauss"
FrameSaver: q=710106 n=646304 tag=gauss
wclsFrameSaver: saving 41192 traces tagged "wiener"
FrameSaver: q=745939 n=592952 tag=wiener
2714 hits in TPC 0
2433 hits in TPC 1
3500 hits in TPC 2
2237 hits in TPC 3
2857 hits in TPC 4
3204 hits in TPC 5
3237 hits in TPC 6
2288 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 50 XUs and 72 XVs -> 4 XUVs
C:0 T:2 8118 XUs and 25826 XVs -> 594 XUVs
C:0 T:3 118 XUs and 204 XVs -> 4 XUVs
C:0 T:4 91 XUs and 58 XVs -> 2 XUVs
C:0 T:5 4131 XUs and 5230 XVs -> 132 XUVs
C:0 T:6 5070 XUs and 8488 XVs -> 325 XUVs
C:0 T:7 452 XUs and 765 XVs -> 28 XUVs
1089 XUVs total
794 collection wire objects
1089 potential space points
Neighbour search...
15051 tests to find 9476 neighbours
Iterating with no regularization...
Begin: 3.95626e+06
0 3.88092e+06
1 3.8771e+06
Now with regularization...
Begin: 3.57934e+06
0 3.57865e+06
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29094 subRun: 1 event: 17275 at 26-Sep-2024 15:49:32 BST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 67060 traces, 67060 summary
Retagger: tagging trace set: gauss with 50003 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 50003 traces tagged "gauss"
FrameSaver: q=1.07481e+06 n=940955 tag=gauss
wclsFrameSaver: saving 67060 traces tagged "wiener"
FrameSaver: q=1.16979e+06 n=855494 tag=wiener
5586 hits in TPC 0
3913 hits in TPC 1
7367 hits in TPC 2
2157 hits in TPC 3
3508 hits in TPC 4
5208 hits in TPC 5
5171 hits in TPC 6
2594 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2302 XUs and 1716 XVs -> 59 XUVs
C:0 T:2 36597 XUs and 19524 XVs -> 563 XUVs
C:0 T:3 317 XUs and 232 XVs -> 11 XUVs
C:0 T:4 127 XUs and 63 XVs -> 3 XUVs
C:0 T:5 20881 XUs and 14439 XVs -> 1251 XUVs
C:0 T:6 20666 XUs and 45265 XVs -> 2507 XUVs
C:0 T:7 191 XUs and 191 XVs -> 9 XUVs
4403 XUVs total
1342 collection wire objects
4403 potential space points
Neighbour search...
404571 tests to find 185234 neighbours
Iterating with no regularization...
Begin: 6.23054e+06
0 5.17694e+06
1 5.11133e+06
2 5.10041e+06
3 5.09634e+06
Now with regularization...
Begin: 4.78785e+06
0 4.78506e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 15:51:33 BST Closed output file "np04hd_raw_run029094_0071_dataflow3_datawriter_0_20240906T090751_reco_stage1_reco_stage2_20240926T145133_keepup.root"
26-Sep-2024 15:51:33 BST Closed input file "np04hd_raw_run029094_0071_dataflow3_datawriter_0_20240906T090751_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 81.2461 112.665 151.361 110.54 20.0143 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000469949 0.00207911 0.00410787 0.00214566 0.000909678 30
produce:fembfilter:PDHDFEMBFilter 0.643127 0.660128 0.700906 0.658345 0.011448 30
produce:wclsdatahd:WireCellToolkit 42.7747 44.0505 46.3425 43.9498 0.921823 30
produce:gaushit:GausHitFinder 0.440478 0.795341 1.58502 0.75022 0.243139 30
produce:nhitsfilter:NumberOfHitsFilter 0.000231706 0.000380236 0.000562513 0.000380004 8.27937e-05 30
produce:reco3d:SpacePointSolver 0.149587 0.88446 4.24866 0.588829 0.871673 30
produce:hitpdune:DisambigFromSpacePoints 0.214753 0.536898 1.06925 0.524695 0.259387 30
produce:pandora:StandardPandora 5.12213 12.5244 22.7699 11.7434 5.2413 30
produce:pandoraWriter:StandardPandora 0.0975481 0.146439 0.203458 0.144072 0.0342054 30
produce:pandoraTrack:LArPandoraTrackCreation 0.546762 1.27743 2.44772 1.28415 0.518548 30
produce:pandoraShower:LArPandoraShowerCreation 0.505741 1.4536 3.35727 1.36149 0.792162 30
produce:pandoracalo:Calorimetry 0.284476 0.635802 1.12793 0.631441 0.235979 30
produce:pandoracalonosce:Calorimetry 0.243617 0.559052 0.968486 0.577991 0.200128 30
produce:pandorapid:Chi2ParticleID 0.00121647 0.00194339 0.00338267 0.00188018 0.000429579 30
produce:pandoraShowercalo:ShowerCalorimetry 0.450903 1.3091 2.82088 1.24363 0.685022 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.447571 1.28279 2.86112 1.22642 0.65904 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0728017 0.132834 0.199338 0.133857 0.0331456 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0262749 0.0443891 0.0679007 0.0441102 0.0107779 30
produce:emtrkmichelid:EmTrackMichelId 27.1238 44.9421 63.5553 43.6465 10.3556 30
[art]:TriggerResults:TriggerResultInserter 2.3173e-05 3.43838e-05 7.8906e-05 2.87745e-05 1.48198e-05 30
end_path:out1:RootOutput 7.293e-06 1.04996e-05 2.7094e-05 8.804e-06 4.29491e-06 30
end_path:michelremoving:michelremoving 0.0196184 0.0821959 0.341752 0.0391613 0.0799739 30
end_path:michelremovinggnocchi:michelremoving 0.0181588 0.0788034 0.338428 0.0338263 0.079075 30
end_path:calibanagnocchi:CalibAnaTree 0.20852 0.456035 0.907295 0.434176 0.18253 30
end_path:out1:RootOutput(write) 0.435601 0.720098 1.04948 0.696086 0.171381 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4914.75 MB
Peak resident set size usage (VmHWM): 2355.25 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029094_0071_dataflow3_datawriter_0_20240906T090751_reco_stage1_reco_stage2_20240926T145133_keepup.root
\tHists: np04hd_raw_run029094_0071_dataflow3_datawriter_0_20240906T090751_reco_stage1_reco_stage2_20240926T145133_keepup_hists.root
Forming reco metadata
/cvmfs/larsoft.opensciencegrid.org/products/python/v3_9_15/Linux64bit+3.10-2.17/bin/python: No module named meta_maker
Error in reco metadata