justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 78460.45@justin-prod-sched02.dune.hep.ac.uk

Jobsub ID78460.45@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3447
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-09-26 09:58:17
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce01
Last heartbeat2024-09-26 11:20:44
From worker nodeHostnameccwcondor0563
cpuinfoAMD EPYC 7453 28-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit106200 (29 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 10:11:10
Input fileshd-protodune:np04hd_raw_run029081_0585_dataflow6_datawriter_0_20240905T015645.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:20:44
Saved logsjustin-logs:78460.45-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

mary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 45395 traces tagged "gauss"
FrameSaver: q=1.00053e+06 n=821315 tag=gauss
wclsFrameSaver: saving 64054 traces tagged "wiener"
FrameSaver: q=1.0838e+06 n=733809 tag=wiener
1936 hits in TPC 0
2774 hits in TPC 1
5873 hits in TPC 2
2415 hits in TPC 3
2869 hits in TPC 4
4251 hits in TPC 5
7957 hits in TPC 6
4469 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 256 XUs and 243 XVs -> 5 XUVs
C:0 T:2 35657 XUs and 46838 XVs -> 1262 XUVs
C:0 T:3 70 XUs and 128 XVs -> 4 XUVs
C:0 T:4 223 XUs and 145 XVs -> 17 XUVs
C:0 T:5 10550 XUs and 11411 XVs -> 517 XUVs
C:0 T:6 78421 XUs and 60549 XVs -> 3172 XUVs
C:0 T:7 204 XUs and 209 XVs -> 14 XUVs
4991 XUVs total
1487 collection wire objects
4991 potential space points
Neighbour search...
363121 tests to find 191050 neighbours
Iterating with no regularization...
Begin: 9.97645e+06
0 8.46891e+06
1 8.39599e+06
2 8.38469e+06
3 8.38147e+06
Now with regularization...
Begin: 8.0119e+06
0 8.00999e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29081 subRun: 1 event: 140638 at 26-Sep-2024 13:15:12 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 63771 traces, 63771 summary
Retagger: tagging trace set: gauss with 46049 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 46049 traces tagged "gauss"
FrameSaver: q=914527 n=816253 tag=gauss
wclsFrameSaver: saving 63771 traces tagged "wiener"
FrameSaver: q=983394 n=723717 tag=wiener
2550 hits in TPC 0
3114 hits in TPC 1
7380 hits in TPC 2
3293 hits in TPC 3
1384 hits in TPC 4
4273 hits in TPC 5
5947 hits in TPC 6
4084 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 92 XUs and 125 XVs -> 48 XUVs
C:0 T:2 31514 XUs and 54429 XVs -> 1319 XUVs
C:0 T:3 30 XUs and 63 XVs -> 1 XUVs
C:0 T:4 33 XUs and 45 XVs -> 3 XUVs
C:0 T:5 6310 XUs and 38592 XVs -> 766 XUVs
C:0 T:6 29057 XUs and 41244 XVs -> 1867 XUVs
C:0 T:7 83 XUs and 112 XVs -> 1 XUVs
4005 XUVs total
1405 collection wire objects
4005 potential space points
Neighbour search...
288215 tests to find 146900 neighbours
Iterating with no regularization...
Begin: 6.1402e+06
0 5.72261e+06
1 5.69014e+06
2 5.68536e+06
Now with regularization...
Begin: 5.20868e+06
0 5.2071e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29081 subRun: 1 event: 140646 at 26-Sep-2024 13:16:25 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 73919 traces, 73919 summary
Retagger: tagging trace set: gauss with 54796 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 54796 traces tagged "gauss"
FrameSaver: q=1.25857e+06 n=1032860 tag=gauss
wclsFrameSaver: saving 73919 traces tagged "wiener"
FrameSaver: q=1.36669e+06 n=939559 tag=wiener
2347 hits in TPC 0
2554 hits in TPC 1
9589 hits in TPC 2
5082 hits in TPC 3
3494 hits in TPC 4
3582 hits in TPC 5
7683 hits in TPC 6
4180 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 744 XUs and 490 XVs -> 52 XUVs
C:0 T:2 92512 XUs and 97541 XVs -> 5430 XUVs
C:0 T:3 37 XUs and 37 XVs -> 2 XUVs
C:0 T:4 29 XUs and 38 XVs -> 1 XUVs
C:0 T:5 5984 XUs and 9553 XVs -> 895 XUVs
C:0 T:6 32619 XUs and 34154 XVs -> 1022 XUVs
C:0 T:7 1493 XUs and 1220 XVs -> 64 XUVs
7466 XUVs total
2157 collection wire objects
7466 potential space points
Neighbour search...
630938 tests to find 332642 neighbours
Iterating with no regularization...
Begin: 1.41243e+07
0 1.29507e+07
1 1.28373e+07
2 1.28213e+07
3 1.28162e+07
Now with regularization...
Begin: 1.18886e+07
0 1.18847e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 13:17:50 CEST  Closed output file "np04hd_raw_run029081_0585_dataflow6_datawriter_0_20240905T015645_reco_stage1_reco_stage2_20240926T111750_keepup.root"
26-Sep-2024 13:17:50 CEST  Closed input file "np04hd_raw_run029081_0585_dataflow6_datawriter_0_20240905T015645_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              65.876        98.6604       144.569       98.1289       19.7721        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000605235   0.00332889    0.00558656    0.00354263     0.0013251       30     
produce:fembfilter:PDHDFEMBFilter                      0.507068      0.691011      0.865113      0.734818       0.10548        30     
produce:wclsdatahd:WireCellToolkit                      31.408        39.8816       46.5286       41.3787       4.57249        30     
produce:gaushit:GausHitFinder                          0.390024      0.707651       1.13838      0.714218      0.154544        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000242865   0.000342038   0.00061368    0.000330725   6.62281e-05      30     
produce:reco3d:SpacePointSolver                        0.250595       1.27097       3.85996      0.921601      0.953304        30     
produce:hitpdune:DisambigFromSpacePoints               0.167011      0.530422       1.49679      0.530618      0.272582        30     
produce:pandora:StandardPandora                         6.11635       12.924        27.4654       12.6672       5.00545        30     
produce:pandoraWriter:StandardPandora                  0.095318      0.164843      0.257534      0.168439      0.0414831       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.929656       1.85832       4.01661       1.75225      0.744163        30     
produce:pandoraShower:LArPandoraShowerCreation         0.806911       2.28976       5.48113       2.20705       1.08528        30     
produce:pandoracalo:Calorimetry                        0.429129      0.904082       1.77471      0.869015      0.315171        30     
produce:pandoracalonosce:Calorimetry                   0.341027      0.843506       2.00043      0.812869      0.325975        30     
produce:pandorapid:Chi2ParticleID                     0.00125485    0.00212086    0.00295115    0.00208394    0.000479318      30     
produce:pandoraShowercalo:ShowerCalorimetry             0.62484       2.00377       5.13532       1.92535      0.974872        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.514149       1.99482       5.45598       1.78284       1.03679        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.082785      0.148822      0.240707      0.150006      0.0418732       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0371836     0.0552763     0.0847786     0.0555327     0.0130787       30     
produce:emtrkmichelid:EmTrackMichelId                   18.2111       30.6197       48.5315       30.7257       7.8305         30     
[art]:TriggerResults:TriggerResultInserter            3.6879e-05    6.32756e-05   0.000153097   5.89655e-05   2.18044e-05      30     
end_path:out1:RootOutput                              1.2553e-05    1.84984e-05   4.1097e-05    1.72175e-05   5.33731e-06      30     
end_path:michelremoving:michelremoving                 0.0246339     0.087952      0.234697      0.0555535     0.0629869       30     
end_path:michelremovinggnocchi:michelremoving          0.0220906     0.0867307     0.245264      0.0535333     0.0647058       30     
end_path:calibanagnocchi:CalibAnaTree                  0.227296       0.62902       1.60803      0.570406      0.269277        30     
end_path:out1:RootOutput(write)                        0.405167      0.747463       1.15632      0.724933      0.162624        30     
========================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 4948.83 MB
  Peak resident set size usage (VmHWM): 2338.91 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_0585_dataflow6_datawriter_0_20240905T015645_reco_stage1_reco_stage2_20240926T111750_keepup.root
\tHists: np04hd_raw_run029081_0585_dataflow6_datawriter_0_20240905T015645_reco_stage1_reco_stage2_20240926T111750_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
justIN time: 2024-11-17 03:57:46 UTC       justIN version: 01.01.09