Jobsub ID 79112.1@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 79112.1@justin-prod-sched02.dune.hep.ac.uk |
Workflow ID | 3460 |
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 14:30:05 |
Site | CZ_FZU |
Entry | Nova_CZ_FZU_osgce1 |
Last heartbeat | 2024-09-26 16:18:02 |
From worker node | Hostname | mikan08.farm.particle.cz |
cpuinfo | Intel(R) Xeon(R) CPU E5-2650 v4 @ 2.20GHz |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 4193255424 (3999 MiB) |
Wall seconds limit | 172800 (48 hours) |
Inner Apptainer? | True |
Job state | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 14:32:22 |
Input files | hd-protodune:np04hd_raw_run029218_0098_dataflow2_datawriter_0_20240917T165220.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 16:18:02 |
Saved logs | justin-logs:79112.1-justin-prod-sched02.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
=604236 tag=wiener
1256 hits in TPC 0
1331 hits in TPC 1
6118 hits in TPC 2
5639 hits in TPC 3
3227 hits in TPC 4
3824 hits in TPC 5
3127 hits in TPC 6
1720 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 118 XUs and 94 XVs -> 1 XUVs
C:0 T:2 49729 XUs and 38650 XVs -> 2769 XUVs
C:0 T:3 373 XUs and 310 XVs -> 17 XUVs
C:0 T:4 84 XUs and 101 XVs -> 7 XUVs
C:0 T:5 7740 XUs and 7043 XVs -> 306 XUVs
C:0 T:6 7945 XUs and 8016 XVs -> 291 XUVs
C:0 T:7 68 XUs and 154 XVs -> 11 XUVs
3402 XUVs total
1152 collection wire objects
3402 potential space points
Neighbour search...
305672 tests to find 96476 neighbours
Iterating with no regularization...
Begin: 1.32156e+07
0 1.04979e+07
1 1.02031e+07
2 1.01465e+07
3 1.01353e+07
4 1.0133e+07
Now with regularization...
Begin: 9.4368e+06
0 9.43149e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29218 subRun: 1 event: 24538 at 26-Sep-2024 18:13:12 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 40352 traces, 40352 summary
Retagger: tagging trace set: gauss with 30375 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 30375 traces tagged "gauss"
FrameSaver: q=628419 n=566884 tag=gauss
wclsFrameSaver: saving 40352 traces tagged "wiener"
FrameSaver: q=674958 n=513896 tag=wiener
2284 hits in TPC 0
2578 hits in TPC 1
3365 hits in TPC 2
1495 hits in TPC 3
839 hits in TPC 4
3125 hits in TPC 5
4750 hits in TPC 6
2650 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 25 XUs and 118 XVs -> 0 XUVs
C:0 T:2 5747 XUs and 11312 XVs -> 438 XUVs
C:0 T:3 158 XUs and 250 XVs -> 13 XUVs
C:0 T:4 5 XUs and 3 XVs -> 0 XUVs
C:0 T:5 9505 XUs and 2425 XVs -> 48 XUVs
C:0 T:6 9814 XUs and 8857 XVs -> 297 XUVs
C:0 T:7 224 XUs and 156 XVs -> 4 XUVs
800 XUVs total
485 collection wire objects
800 potential space points
Neighbour search...
12490 tests to find 7954 neighbours
Iterating with no regularization...
Begin: 2.97139e+06
0 2.78603e+06
1 2.7734e+06
2 2.77135e+06
Now with regularization...
Begin: 2.59097e+06
0 2.59059e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 31st record. run: 29218 subRun: 1 event: 24546 at 26-Sep-2024 18:15:20 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 60489 traces, 60489 summary
Retagger: tagging trace set: gauss with 44483 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 44483 traces tagged "gauss"
FrameSaver: q=951280 n=813536 tag=gauss
wclsFrameSaver: saving 60489 traces tagged "wiener"
FrameSaver: q=1.02679e+06 n=734628 tag=wiener
2249 hits in TPC 0
2627 hits in TPC 1
5732 hits in TPC 2
3738 hits in TPC 3
1672 hits in TPC 4
4143 hits in TPC 5
5973 hits in TPC 6
4924 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2484 XUs and 919 XVs -> 0 XUVs
C:0 T:2 12944 XUs and 10458 XVs -> 336 XUVs
C:0 T:3 349 XUs and 285 XVs -> 12 XUVs
C:0 T:4 177 XUs and 186 XVs -> 9 XUVs
C:0 T:5 4868 XUs and 5285 XVs -> 265 XUVs
C:0 T:6 22428 XUs and 21818 XVs -> 1917 XUVs
C:0 T:7 2530 XUs and 3019 XVs -> 36 XUVs
2575 XUVs total
967 collection wire objects
2575 potential space points
Neighbour search...
140883 tests to find 87586 neighbours
Iterating with no regularization...
Begin: 4.4303e+06
0 4.1514e+06
1 4.13054e+06
2 4.12569e+06
3 4.12372e+06
Now with regularization...
Begin: 3.82001e+06
0 3.81877e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 18:17:39 CEST Closed output file "np04hd_raw_run029218_0098_dataflow2_datawriter_0_20240917T165220_reco_stage1_reco_stage2_20240926T161739_keepup.root"
26-Sep-2024 18:17:39 CEST Closed input file "np04hd_raw_run029218_0098_dataflow2_datawriter_0_20240917T165220_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 103.391 143.457 207.478 134.518 26.5805 31
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000399547 0.00248903 0.00422905 0.00259877 0.00102799 31
produce:fembfilter:PDHDFEMBFilter 0.708869 1.01467 1.1826 1.09667 0.149257 31
produce:wclsdatahd:WireCellToolkit 52.0544 62.5905 74.352 62.2832 5.74621 31
produce:gaushit:GausHitFinder 0.542687 1.08021 1.87903 1.08498 0.357437 31
produce:nhitsfilter:NumberOfHitsFilter 0.00028419 0.000485279 0.00104091 0.000488282 0.000154407 31
produce:reco3d:SpacePointSolver 0.210945 1.11484 3.04339 0.934792 0.727234 31
produce:hitpdune:DisambigFromSpacePoints 0.289019 0.952061 2.02868 0.85336 0.504498 31
produce:pandora:StandardPandora 6.32357 19.5042 43.7759 16.6301 8.72824 31
produce:pandoraWriter:StandardPandora 0.115185 0.215912 0.329711 0.216461 0.0639478 31
produce:pandoraTrack:LArPandoraTrackCreation 0.631011 1.92644 4.10252 1.77522 0.917144 31
produce:pandoraShower:LArPandoraShowerCreation 0.657933 2.29019 5.24395 1.91387 1.29435 31
produce:pandoracalo:Calorimetry 0.359358 0.940398 1.86562 0.88426 0.388155 31
produce:pandoracalonosce:Calorimetry 0.301154 0.852134 1.7538 0.784796 0.380343 31
produce:pandorapid:Chi2ParticleID 0.00127919 0.00259331 0.00570948 0.00251456 0.000889612 31
produce:pandoraShowercalo:ShowerCalorimetry 0.596359 2.0075 4.44257 1.72025 1.13404 31
produce:pandoraShowercalonosce:ShowerCalorimetry 0.597375 1.92585 4.39485 1.71959 1.02935 31
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0987881 0.203998 0.389781 0.190515 0.0691233 31
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.041618 0.0755137 0.135998 0.0680113 0.0248179 31
produce:emtrkmichelid:EmTrackMichelId 30.684 44.2547 65.9121 41.4855 9.12071 31
[art]:TriggerResults:TriggerResultInserter 3.1213e-05 4.59825e-05 0.000128974 4.188e-05 1.69533e-05 31
end_path:out1:RootOutput 8.981e-06 1.25532e-05 4.0806e-05 1.1576e-05 5.27225e-06 31
end_path:michelremoving:michelremoving 0.0225848 0.147966 0.803037 0.0565048 0.155275 31
end_path:michelremovinggnocchi:michelremoving 0.0199648 0.143221 0.793069 0.0543519 0.154302 31
end_path:calibanagnocchi:CalibAnaTree 0.256848 0.766771 1.39404 0.723859 0.284574 31
end_path:out1:RootOutput(write) 0.610884 1.34247 2.19278 1.32677 0.379568 31
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4949.73 MB
Peak resident set size usage (VmHWM): 2615.83 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029218_0098_dataflow2_datawriter_0_20240917T165220_reco_stage1_reco_stage2_20240926T161739_keepup.root
\tHists: np04hd_raw_run029218_0098_dataflow2_datawriter_0_20240917T165220_reco_stage1_reco_stage2_20240926T161739_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