justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 263295.1@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID263295.1@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3453
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:35
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce03
Last heartbeat2024-09-26 11:18:08
From worker nodeHostnameccwcondor0601
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:03:39
Input fileshd-protodune:np04hd_raw_run029107_3652_dataflow3_datawriter_0_20240909T044315.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:18:08
Saved logsjustin-logs:263295.1-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

ener"
FrameSaver: q=1.11672e+06 n=754939 tag=wiener
2550 hits in TPC 0
4067 hits in TPC 1
6665 hits in TPC 2
6016 hits in TPC 3
1755 hits in TPC 4
3038 hits in TPC 5
5576 hits in TPC 6
3796 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 38 XUs and 23 XVs -> 2 XUVs
C:0 T:1 17367 XUs and 14117 XVs -> 56 XUVs
C:0 T:2 41509 XUs and 31204 XVs -> 1301 XUVs
C:0 T:3 61 XUs and 77 XVs -> 4 XUVs
C:0 T:4 109 XUs and 133 XVs -> 3 XUVs
C:0 T:5 4287 XUs and 15247 XVs -> 570 XUVs
C:0 T:6 58750 XUs and 44636 XVs -> 1458 XUVs
C:0 T:7 4 XUs and 0 XVs -> 0 XUVs
3394 XUVs total
1633 collection wire objects
3394 potential space points
Neighbour search...
142228 tests to find 67080 neighbours
Iterating with no regularization...
Begin: 1.09417e+07
0 9.75192e+06
1 9.66204e+06
2 9.65275e+06
Now with regularization...
Begin: 8.95077e+06
0 8.94658e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 876731 at 26-Sep-2024 13:05:34 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 57715 traces, 57715 summary
Retagger: tagging trace set: gauss with 43126 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 43126 traces tagged "gauss"
FrameSaver: q=949054 n=869687 tag=gauss
wclsFrameSaver: saving 57715 traces tagged "wiener"
FrameSaver: q=1.03203e+06 n=802939 tag=wiener
3104 hits in TPC 0
2773 hits in TPC 1
2798 hits in TPC 2
1234 hits in TPC 3
6378 hits in TPC 4
7624 hits in TPC 5
5746 hits in TPC 6
4558 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 71 XUs and 53 XVs -> 9 XUVs
C:0 T:1 464 XUs and 727 XVs -> 12 XUVs
C:0 T:2 6186 XUs and 8064 XVs -> 454 XUVs
C:0 T:4 313 XUs and 474 XVs -> 6 XUVs
C:0 T:5 39181 XUs and 90382 XVs -> 2551 XUVs
C:0 T:6 21415 XUs and 19104 XVs -> 768 XUVs
C:0 T:7 613 XUs and 904 XVs -> 51 XUVs
3851 XUVs total
1593 collection wire objects
3851 potential space points
Neighbour search...
130867 tests to find 74266 neighbours
Iterating with no regularization...
Begin: 8.5304e+06
0 6.30465e+06
1 6.15167e+06
2 6.13741e+06
3 6.13264e+06
Now with regularization...
Begin: 5.75385e+06
0 5.75157e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29107 subRun: 1 event: 876739 at 26-Sep-2024 13:06:44 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 97821 traces, 97821 summary
Retagger: tagging trace set: gauss with 71844 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 71844 traces tagged "gauss"
FrameSaver: q=1.63671e+06 n=1270427 tag=gauss
wclsFrameSaver: saving 97821 traces tagged "wiener"
FrameSaver: q=1.78661e+06 n=1151315 tag=wiener
5762 hits in TPC 0
4006 hits in TPC 1
8486 hits in TPC 2
5709 hits in TPC 3
6032 hits in TPC 4
7941 hits in TPC 5
7125 hits in TPC 6
3667 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2683 XUs and 1885 XVs -> 25 XUVs
C:0 T:2 64198 XUs and 64815 XVs -> 1256 XUVs
C:0 T:3 590 XUs and 615 XVs -> 20 XUVs
C:0 T:4 99 XUs and 102 XVs -> 7 XUVs
C:0 T:5 47377 XUs and 44053 XVs -> 1230 XUVs
C:0 T:6 72231 XUs and 80535 XVs -> 3569 XUVs
C:0 T:7 74 XUs and 232 XVs -> 1 XUVs
6108 XUVs total
2148 collection wire objects
6108 potential space points
Neighbour search...
431630 tests to find 219044 neighbours
Iterating with no regularization...
Begin: 1.98479e+07
0 1.8592e+07
1 1.8509e+07
2 1.84977e+07
Now with regularization...
Begin: 1.74836e+07
0 1.74804e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 13:08:28 CEST  Closed output file "np04hd_raw_run029107_3652_dataflow3_datawriter_0_20240909T044315_reco_stage1_reco_stage2_20240926T110828_keepup.root"
26-Sep-2024 13:08:28 CEST  Closed input file "np04hd_raw_run029107_3652_dataflow3_datawriter_0_20240909T044315_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              65.8223       96.4598       142.945       90.1717       22.2255        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000627072    0.0027544    0.00459117     0.0027536    0.00107708       30     
produce:fembfilter:PDHDFEMBFilter                      0.494658      0.626571      0.764544      0.630352      0.0889939       30     
produce:wclsdatahd:WireCellToolkit                      31.9143       38.9993       46.2446       39.174        4.48426        30     
produce:gaushit:GausHitFinder                          0.419075      0.661033       1.0776       0.656198      0.178587        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000227184   0.00032465    0.000621081   0.000317177   7.68693e-05      30     
produce:reco3d:SpacePointSolver                        0.158563       1.25063       9.64045      0.753904       1.75584        30     
produce:hitpdune:DisambigFromSpacePoints                0.14051      0.476022       1.23168      0.449624      0.232426        30     
produce:pandora:StandardPandora                         5.32532       14.445        40.5072       12.6951       8.02915        30     
produce:pandoraWriter:StandardPandora                  0.0807287     0.155241      0.263623      0.148139      0.045139        30     
produce:pandoraTrack:LArPandoraTrackCreation           0.553659       1.6502        3.33487       1.42921      0.785625        30     
produce:pandoraShower:LArPandoraShowerCreation         0.597828       2.15543       5.53038       1.93285       1.25354        30     
produce:pandoracalo:Calorimetry                        0.307482      0.774653       1.43128      0.704073      0.325283        30     
produce:pandoracalonosce:Calorimetry                   0.273342       0.71692       1.67204      0.615812      0.348626        30     
produce:pandorapid:Chi2ParticleID                     0.00102822    0.00199521     0.0036061    0.00176832    0.00063325       30     
produce:pandoraShowercalo:ShowerCalorimetry            0.574883       1.80538       4.80912       1.67069       1.00479        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.428334       1.66535       4.16255       1.50345      0.890422        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.067432      0.127929      0.249851      0.114733      0.0447509       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0258414     0.0465538     0.0857375     0.041291      0.015706        30     
produce:emtrkmichelid:EmTrackMichelId                   19.2834       29.3458       45.0503       27.9986       6.93184        30     
[art]:TriggerResults:TriggerResultInserter            3.7831e-05    6.05147e-05   0.000133098   6.0488e-05    1.99378e-05      30     
end_path:out1:RootOutput                               8.806e-06    1.64312e-05   5.3209e-05    1.4893e-05    7.67942e-06      30     
end_path:michelremoving:michelremoving                 0.0187816     0.0716125     0.360831      0.0389946     0.0735734       30     
end_path:michelremovinggnocchi:michelremoving          0.0184794     0.0672177     0.287687      0.0357902      0.06383        30     
end_path:calibanagnocchi:CalibAnaTree                  0.212331      0.513294       1.23858       0.42087      0.239582        30     
end_path:out1:RootOutput(write)                        0.391835      0.691966       1.0454        0.66126      0.179234        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4923.05 MB
  Peak resident set size usage (VmHWM): 2341.94 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_3652_dataflow3_datawriter_0_20240909T044315_reco_stage1_reco_stage2_20240926T110828_keepup.root
\tHists: np04hd_raw_run029107_3652_dataflow3_datawriter_0_20240909T044315_reco_stage1_reco_stage2_20240926T110828_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-09-29 09:27:59 UTC       justIN version: 01.01.08