justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID79112.1@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3460
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 14:30:05
SiteCZ_FZU
EntryNova_CZ_FZU_osgce1
Last heartbeat2024-09-26 16:18:02
From worker nodeHostnamemikan08.farm.particle.cz
cpuinfoIntel(R) Xeon(R) CPU E5-2650 v4 @ 2.20GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit172800 (48 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 14:32:22
Input fileshd-protodune:np04hd_raw_run029218_0098_dataflow2_datawriter_0_20240917T165220.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 16:18:02
Saved logsjustin-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
justIN time: 2024-11-17 08:14:16 UTC       justIN version: 01.01.09