justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78425.113@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3451
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:30:37
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce03
Last heartbeat2024-09-26 11:23:05
From worker nodeHostnameccwcondor0628
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 09:52:17
Input fileshd-protodune:np04hd_raw_run029107_2282_dataflow3_datawriter_0_20240908T044935.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:23:05
Saved logsjustin-logs:78425.113-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

3e+06 n=709665 tag=wiener
3186 hits in TPC 0
3785 hits in TPC 1
5457 hits in TPC 2
4450 hits in TPC 3
2352 hits in TPC 4
4907 hits in TPC 5
4284 hits in TPC 6
2511 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1084 XUs and 686 XVs -> 63 XUVs
C:0 T:2 28596 XUs and 20548 XVs -> 1403 XUVs
C:0 T:3 220 XUs and 337 XVs -> 22 XUVs
C:0 T:4 51 XUs and 74 XVs -> 3 XUVs
C:0 T:5 31506 XUs and 98039 XVs -> 2466 XUVs
C:0 T:6 20578 XUs and 15028 XVs -> 331 XUVs
C:0 T:7 60 XUs and 126 XVs -> 3 XUVs
4291 XUVs total
991 collection wire objects
4291 potential space points
Neighbour search...
286729 tests to find 156056 neighbours
Iterating with no regularization...
Begin: 7.53312e+06
0 6.73236e+06
1 6.66913e+06
2 6.65821e+06
3 6.65514e+06
Now with regularization...
Begin: 6.35139e+06
0 6.34981e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 547931 at 26-Sep-2024 13:05:11 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 63442 traces, 63442 summary
Retagger: tagging trace set: gauss with 49797 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 49797 traces tagged "gauss"
FrameSaver: q=1.13575e+06 n=1005901 tag=gauss
wclsFrameSaver: saving 63442 traces tagged "wiener"
FrameSaver: q=1.1973e+06 n=926401 tag=wiener
2254 hits in TPC 0
2309 hits in TPC 1
4532 hits in TPC 2
1804 hits in TPC 3
5468 hits in TPC 4
8427 hits in TPC 5
6093 hits in TPC 6
4085 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 34 XUs and 458 XVs -> 0 XUVs
C:0 T:2 23281 XUs and 9076 XVs -> 319 XUVs
C:0 T:3 86 XUs and 65 XVs -> 5 XUVs
C:0 T:4 262 XUs and 263 XVs -> 13 XUVs
C:0 T:5 30069 XUs and 27188 XVs -> 600 XUVs
C:0 T:6 15284 XUs and 22150 XVs -> 982 XUVs
C:0 T:7 95 XUs and 149 XVs -> 13 XUVs
1932 XUVs total
1177 collection wire objects
1932 potential space points
Neighbour search...
21808 tests to find 12944 neighbours
Iterating with no regularization...
Begin: 1.0303e+07
0 9.95885e+06
1 9.94275e+06
2 9.94113e+06
Now with regularization...
Begin: 9.29876e+06
0 9.29805e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29107 subRun: 1 event: 547939 at 26-Sep-2024 13:06:38 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 52608 traces, 52608 summary
Retagger: tagging trace set: gauss with 38575 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 38575 traces tagged "gauss"
FrameSaver: q=829367 n=724894 tag=gauss
wclsFrameSaver: saving 52608 traces tagged "wiener"
FrameSaver: q=884588 n=650020 tag=wiener
2863 hits in TPC 0
2253 hits in TPC 1
4124 hits in TPC 2
2440 hits in TPC 3
1435 hits in TPC 4
4174 hits in TPC 5
6017 hits in TPC 6
3121 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 96 XUs and 142 XVs -> 9 XUVs
C:0 T:2 20587 XUs and 26883 XVs -> 1100 XUVs
C:0 T:3 119 XUs and 139 XVs -> 4 XUVs
C:0 T:4 54 XUs and 104 XVs -> 2 XUVs
C:0 T:5 4336 XUs and 7340 XVs -> 509 XUVs
C:0 T:6 20292 XUs and 18777 XVs -> 902 XUVs
C:0 T:7 8 XUs and 20 XVs -> 0 XUVs
2526 XUVs total
1133 collection wire objects
2526 potential space points
Neighbour search...
190326 tests to find 107668 neighbours
Iterating with no regularization...
Begin: 4.79838e+06
0 4.43663e+06
1 4.42013e+06
2 4.41701e+06
Now with regularization...
Begin: 4.07212e+06
0 4.07128e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 13:07:39 CEST  Closed output file "np04hd_raw_run029107_2282_dataflow3_datawriter_0_20240908T044935_reco_stage1_reco_stage2_20240926T110739_keepup.root"
26-Sep-2024 13:07:39 CEST  Closed input file "np04hd_raw_run029107_2282_dataflow3_datawriter_0_20240908T044935_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              59.9946       121.377       1122.95       86.4498       187.075        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000376434   0.00257095    0.00461729     0.0027112     0.0011165       30     
produce:fembfilter:PDHDFEMBFilter                      0.491825      0.569841      0.753455      0.542734      0.0786404       30     
produce:wclsdatahd:WireCellToolkit                      31.5328       35.5858       43.1634       34.2434       3.13743        30     
produce:gaushit:GausHitFinder                           0.34955      0.646823       1.67002      0.622764       0.25921        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000233928   0.000326111   0.000517438   0.000299555   8.2435e-05       30     
produce:reco3d:SpacePointSolver                        0.154741      0.956699       7.13694      0.574666       1.37386        30     
produce:hitpdune:DisambigFromSpacePoints               0.155943      0.518554       3.39067      0.363818      0.580094        30     
produce:pandora:StandardPandora                         4.56269       43.7434       976.528       10.7308       173.312        30     
produce:pandoraWriter:StandardPandora                  0.0798668     0.142736      0.269448      0.138941      0.0471341       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.640693       1.61535       5.77662       1.30225       1.07812        30     
produce:pandoraShower:LArPandoraShowerCreation         0.547057       2.13479       9.66915       1.4164        1.85322        30     
produce:pandoracalo:Calorimetry                        0.288537      0.816899       2.89804       0.66469      0.562809        30     
produce:pandoracalonosce:Calorimetry                    0.26327      0.744105       2.44758      0.590411      0.507289        30     
produce:pandorapid:Chi2ParticleID                     0.00114775    0.00187316    0.00360548    0.00163404    0.000665371      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.448115       1.86479       7.45404       1.49118       1.47128        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.436734       1.76503       7.35501       1.36701       1.39587        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.057225      0.118629      0.223959      0.116008      0.0435558       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0228964     0.0444616     0.0869475     0.0402917     0.0154985       30     
produce:emtrkmichelid:EmTrackMichelId                   17.487        28.4293       53.2737       28.1287       8.33912        30     
[art]:TriggerResults:TriggerResultInserter            2.7291e-05    5.21403e-05   9.4026e-05    4.8491e-05    1.67131e-05      30     
end_path:out1:RootOutput                               7.564e-06    1.50599e-05   3.0487e-05    1.41615e-05   4.76614e-06      30     
end_path:michelremoving:michelremoving                 0.0195572     0.104622      0.444477      0.0430496     0.110373        30     
end_path:michelremovinggnocchi:michelremoving          0.0185567     0.0984511     0.437152      0.0377912     0.106798        30     
end_path:calibanagnocchi:CalibAnaTree                  0.186898      0.566413       1.82463      0.456333      0.337184        30     
end_path:out1:RootOutput(write)                        0.398051      0.680253       1.27243      0.666552      0.211941        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4993.76 MB
  Peak resident set size usage (VmHWM): 2413.99 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_2282_dataflow3_datawriter_0_20240908T044935_reco_stage1_reco_stage2_20240926T110739_keepup.root
\tHists: np04hd_raw_run029107_2282_dataflow3_datawriter_0_20240908T044935_reco_stage1_reco_stage2_20240926T110739_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:26:34 UTC       justIN version: 01.01.08