justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78447.0@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3455
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:51:00
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce03
Last heartbeat2024-09-26 11:08:10
From worker nodeHostnameccwcondor0786
cpuinfoAMD EPYC 7302 16-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 09:51:55
Input fileshd-protodune:np04hd_raw_run029109_0661_dataflow6_datawriter_0_20240910T040747.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:08:10
Saved logsjustin-logs:78447.0-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

213370 neighbours
Iterating with no regularization...
Begin: 1.20498e+07
0 1.08486e+07
1 1.07409e+07
2 1.07267e+07
3 1.07221e+07
Now with regularization...
Begin: 9.88946e+06
0 9.88607e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29109 subRun: 1 event: 158902 at 26-Sep-2024 12:56:33 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 67206 traces, 67206 summary
Retagger: tagging trace set: gauss with 52398 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 52398 traces tagged "gauss"
FrameSaver: q=1.19914e+06 n=1028792 tag=gauss
wclsFrameSaver: saving 67206 traces tagged "wiener"
FrameSaver: q=1.27564e+06 n=943989 tag=wiener
1882 hits in TPC 0
2670 hits in TPC 1
3626 hits in TPC 2
2847 hits in TPC 3
5684 hits in TPC 4
10672 hits in TPC 5
5288 hits in TPC 6
4622 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 472 XUs and 1095 XVs -> 25 XUVs
C:0 T:2 7752 XUs and 10812 XVs -> 171 XUVs
C:0 T:3 71 XUs and 81 XVs -> 6 XUVs
C:0 T:4 105 XUs and 154 XVs -> 6 XUVs
C:0 T:5 35849 XUs and 44347 XVs -> 1383 XUVs
C:0 T:6 23283 XUs and 19146 XVs -> 871 XUVs
C:0 T:7 4 XUs and 7 XVs -> 0 XUVs
2462 XUVs total
1439 collection wire objects
2462 potential space points
Neighbour search...
51066 tests to find 29788 neighbours
Iterating with no regularization...
Begin: 9.07053e+06
0 8.67851e+06
1 8.65312e+06
2 8.64896e+06
Now with regularization...
Begin: 8.10916e+06
0 8.10757e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  10   event 158902 TrkackID 1 startx, y, z 40.875 598.424 8.97392  wireno, peakt tpcno 436 4548.43 5 dist 0min T, max_T4496.26 5118.69
no of hits closeby  4   event 158902 TrkackID 11 startx, y, z 108.967 293.046 452.559  wireno, peakt tpcno 104 3365.88 5 dist 3.10693min T, max_T3242.33 4614.29
no of hits closeby  10   event 158902 TrkackID 1 startx, y, z 40.875 598.424 8.97392  wireno, peakt tpcno 436 4548.43 5 dist 0min T, max_T4496.26 5118.69
no of hits closeby  4   event 158902 TrkackID 11 startx, y, z 108.967 293.046 452.559  wireno, peakt tpcno 104 3365.88 5 dist 3.10693min T, max_T3242.33 4614.29
Begin processing the 30th record. run: 29109 subRun: 1 event: 158910 at 26-Sep-2024 12:58:00 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 49068 traces, 49068 summary
Retagger: tagging trace set: gauss with 37722 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 37722 traces tagged "gauss"
FrameSaver: q=777051 n=712704 tag=gauss
wclsFrameSaver: saving 49068 traces tagged "wiener"
FrameSaver: q=829025 n=649151 tag=wiener
4068 hits in TPC 0
3345 hits in TPC 1
3504 hits in TPC 2
1294 hits in TPC 3
4532 hits in TPC 4
5563 hits in TPC 5
2479 hits in TPC 6
1038 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 266 XUs and 247 XVs -> 5 XUVs
C:0 T:2 4650 XUs and 6748 XVs -> 259 XUVs
C:0 T:3 379 XUs and 468 XVs -> 19 XUVs
C:0 T:4 202 XUs and 376 XVs -> 6 XUVs
C:0 T:5 17045 XUs and 27275 XVs -> 1133 XUVs
C:0 T:6 9893 XUs and 3160 XVs -> 186 XUVs
C:0 T:7 20 XUs and 46 XVs -> 1 XUVs
1609 XUVs total
750 collection wire objects
1609 potential space points
Neighbour search...
59963 tests to find 37718 neighbours
Iterating with no regularization...
Begin: 4.93977e+06
0 4.57891e+06
1 4.55925e+06
2 4.55739e+06
Now with regularization...
Begin: 4.30552e+06
0 4.30458e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 12:59:06 CEST  Closed output file "np04hd_raw_run029109_0661_dataflow6_datawriter_0_20240910T040747_reco_stage1_reco_stage2_20240926T105906_keepup.root"
26-Sep-2024 12:59:06 CEST  Closed input file "np04hd_raw_run029109_0661_dataflow6_datawriter_0_20240910T040747_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              58.4965       94.8224       145.071       95.5325       21.199         30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000384822   0.00308364    0.00592151    0.00264533    0.00147212       30     
produce:fembfilter:PDHDFEMBFilter                      0.537311      0.689414      0.824297      0.693656      0.0981454       30     
produce:wclsdatahd:WireCellToolkit                      35.4846        43.78        50.1249       44.6354       4.72554        30     
produce:gaushit:GausHitFinder                          0.268179      0.672326       1.19076      0.701481      0.218439        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000225072   0.000419093   0.00081559    0.000388488   0.000126146      30     
produce:reco3d:SpacePointSolver                        0.187164       1.17852       5.75162      0.823499       1.19481        30     
produce:hitpdune:DisambigFromSpacePoints               0.105103      0.512803       1.25751      0.481821      0.288362        30     
produce:pandora:StandardPandora                         4.47308       11.3064       24.2343       11.0415       4.66328        30     
produce:pandoraWriter:StandardPandora                  0.078653       0.15316       0.29596      0.149294      0.0593906       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.390348       1.13032       2.4621        1.13799      0.520834        30     
produce:pandoraShower:LArPandoraShowerCreation         0.282002       1.28715       3.41896       1.3307       0.697056        30     
produce:pandoracalo:Calorimetry                        0.184937      0.564641       1.08165      0.575749      0.245259        30     
produce:pandoracalonosce:Calorimetry                   0.162752      0.497424      0.881913      0.503313      0.207282        30     
produce:pandorapid:Chi2ParticleID                     0.000935064   0.00184819    0.00274507    0.00172774    0.000538644      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.252028       1.19866       3.53855       1.14455      0.722911        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.244192       1.13775       3.20194       1.12281      0.648223        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0532488     0.144936      0.290301      0.143724      0.0578163       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0203794     0.0485324     0.0915271     0.046282      0.0191394       30     
produce:emtrkmichelid:EmTrackMichelId                   14.2215       29.0227       46.0845       29.818        8.58839        30     
[art]:TriggerResults:TriggerResultInserter            1.9607e-05    4.74089e-05   0.000107972   3.9689e-05    2.38075e-05      30     
end_path:out1:RootOutput                               6.963e-06    1.11966e-05    3.19e-05     9.9085e-06    4.60289e-06      30     
end_path:michelremoving:michelremoving                 0.0162488     0.0712551     0.334166      0.0398398     0.0669912       30     
end_path:michelremovinggnocchi:michelremoving          0.0146368     0.0690856     0.328112      0.0382785     0.067546        30     
end_path:calibanagnocchi:CalibAnaTree                  0.143229      0.426568      0.741733      0.441973      0.171105        30     
end_path:out1:RootOutput(write)                        0.399229      0.774753       1.23376      0.797241      0.226043        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4934.16 MB
  Peak resident set size usage (VmHWM): 2348.74 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029109_0661_dataflow6_datawriter_0_20240910T040747_reco_stage1_reco_stage2_20240926T105906_keepup.root
\tHists: np04hd_raw_run029109_0661_dataflow6_datawriter_0_20240910T040747_reco_stage1_reco_stage2_20240926T105906_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:12:53 UTC       justIN version: 01.01.09