justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78473.18@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3448
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 10:02:36
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 11:50:29
From worker nodeHostnameccwcondor0591
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:29:34
Input fileshd-protodune:np04hd_raw_run029097_0073_dataflow3_datawriter_0_20240906T115026.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:50:29
Saved logsjustin-logs:78473.18-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

> 11 XUVs
C:0 T:2 31453 XUs and 25460 XVs -> 1508 XUVs
C:0 T:3 456 XUs and 524 XVs -> 7 XUVs
C:0 T:4 54 XUs and 66 XVs -> 5 XUVs
C:0 T:5 7267 XUs and 7178 XVs -> 382 XUVs
C:0 T:6 15132 XUs and 12024 XVs -> 445 XUVs
C:0 T:7 271 XUs and 191 XVs -> 5 XUVs
2363 XUVs total
1308 collection wire objects
2363 potential space points
Neighbour search...
48013 tests to find 28156 neighbours
Iterating with no regularization...
Begin: 6.13331e+06
0 5.84558e+06
1 5.82672e+06
2 5.82337e+06
Now with regularization...
Begin: 5.33003e+06
0 5.32883e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29097 subRun: 1 event: 17747 at 26-Sep-2024 13:31:31 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 81014 traces, 81014 summary
Retagger: tagging trace set: gauss with 58460 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 58460 traces tagged "gauss"
FrameSaver: q=1.39584e+06 n=1084117 tag=gauss
wclsFrameSaver: saving 81014 traces tagged "wiener"
FrameSaver: q=1.53912e+06 n=979191 tag=wiener
2184 hits in TPC 0
2572 hits in TPC 1
9166 hits in TPC 2
5544 hits in TPC 3
4567 hits in TPC 4
9342 hits in TPC 5
5381 hits in TPC 6
4083 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 520 XUs and 784 XVs -> 1 XUVs
C:0 T:2 26155 XUs and 38606 XVs -> 1860 XUVs
C:0 T:3 792 XUs and 913 XVs -> 23 XUVs
C:0 T:4 38 XUs and 43 XVs -> 1 XUVs
C:0 T:5 50498 XUs and 130891 XVs -> 1981 XUVs
C:0 T:6 11120 XUs and 21562 XVs -> 1058 XUVs
C:0 T:7 755 XUs and 617 XVs -> 24 XUVs
4948 XUVs total
2264 collection wire objects
4948 potential space points
Neighbour search...
216092 tests to find 98680 neighbours
Iterating with no regularization...
Begin: 2.05023e+07
0 1.84953e+07
1 1.83757e+07
2 1.83587e+07
Now with regularization...
Begin: 1.7067e+07
0 1.70598e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29097 subRun: 1 event: 17763 at 26-Sep-2024 13:33:10 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 57915 traces, 57915 summary
Retagger: tagging trace set: gauss with 43830 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 43830 traces tagged "gauss"
FrameSaver: q=854637 n=803513 tag=gauss
wclsFrameSaver: saving 57915 traces tagged "wiener"
FrameSaver: q=935745 n=727721 tag=wiener
3592 hits in TPC 0
3593 hits in TPC 1
6156 hits in TPC 2
1845 hits in TPC 3
2381 hits in TPC 4
6048 hits in TPC 5
5957 hits in TPC 6
2544 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 21 XUs and 19 XVs -> 0 XUVs
C:0 T:1 29818 XUs and 35305 XVs -> 1823 XUVs
C:0 T:2 11696 XUs and 36941 XVs -> 509 XUVs
C:0 T:3 14 XUs and 23 XVs -> 0 XUVs
C:0 T:4 39 XUs and 54 XVs -> 1 XUVs
C:0 T:5 17759 XUs and 48717 XVs -> 597 XUVs
C:0 T:6 10768 XUs and 25471 XVs -> 645 XUVs
C:0 T:7 865 XUs and 1040 XVs -> 32 XUVs
3607 XUVs total
1213 collection wire objects
3607 potential space points
Neighbour search...
216389 tests to find 132718 neighbours
Iterating with no regularization...
Begin: 5.44978e+06
0 5.06506e+06
1 5.03737e+06
2 5.03533e+06
Now with regularization...
Begin: 4.85402e+06
0 4.85347e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  1   event 17763 TrkackID 2 startx, y, z -127.158 364.144 456.875  wireno, peakt tpcno 15 2420.76 2 dist 0min T, max_T1378.12 3008.61
no of hits closeby  1   event 17763 TrkackID 2 startx, y, z -127.158 364.144 456.875  wireno, peakt tpcno 15 2420.76 2 dist 0min T, max_T1378.12 3008.61
26-Sep-2024 13:34:25 CEST  Closed output file "np04hd_raw_run029097_0073_dataflow3_datawriter_0_20240906T115026_reco_stage1_reco_stage2_20240926T113425_keepup.root"
26-Sep-2024 13:34:25 CEST  Closed input file "np04hd_raw_run029097_0073_dataflow3_datawriter_0_20240906T115026_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              48.4323       96.3658       208.023       88.7438       32.1103        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000470531   0.00280702    0.00511521    0.00302147    0.00118911       30     
produce:fembfilter:PDHDFEMBFilter                      0.491977      0.575873      0.787289      0.545254      0.0883361       30     
produce:wclsdatahd:WireCellToolkit                      30.9227        35.19        41.7461       34.5282       2.83283        30     
produce:gaushit:GausHitFinder                          0.224386      0.627461       1.26096      0.642322      0.186752        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000194364   0.000326274   0.000728543   0.000295443   0.000106554      30     
produce:reco3d:SpacePointSolver                        0.278979       1.21828       3.68806       1.11675      0.809567        30     
produce:hitpdune:DisambigFromSpacePoints               0.127637      0.548323       1.75276      0.439897      0.320485        30     
produce:pandora:StandardPandora                         2.31152       16.2953       89.6318       11.5706       19.6414        30     
produce:pandoraWriter:StandardPandora                  0.0545241      0.14501      0.276899      0.140534      0.0416763       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.291397       1.79876       4.78817       1.58289       1.00505        30     
produce:pandoraShower:LArPandoraShowerCreation         0.259437       2.38221       6.83298       2.01366       1.55371        30     
produce:pandoracalo:Calorimetry                        0.157741      0.892484       2.60553      0.801953      0.475325        30     
produce:pandoracalonosce:Calorimetry                   0.141978      0.852265       2.48178      0.719446      0.481633        30     
produce:pandorapid:Chi2ParticleID                     0.000853267    0.0018616    0.00329113    0.00157642    0.000564517      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.233616       2.12879       6.81506       1.60948       1.4482         30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.221869       2.00955        5.952        1.56037       1.35119        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0509156     0.129645      0.239645      0.117999      0.0432417       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0188691     0.0497547     0.0905917     0.0499532     0.0161134       30     
produce:emtrkmichelid:EmTrackMichelId                   11.8919       29.7216       42.1217       29.5353       6.90712        30     
[art]:TriggerResults:TriggerResultInserter            3.0287e-05    5.83933e-05   0.000111599   5.69415e-05   1.69079e-05      30     
end_path:out1:RootOutput                              1.0199e-05    1.7253e-05    3.9264e-05     1.619e-05    5.43323e-06      30     
end_path:michelremoving:michelremoving                 0.0217519     0.118282      0.395756      0.0749494     0.0919467       30     
end_path:michelremovinggnocchi:michelremoving          0.0166784     0.104294      0.385038      0.0720689      0.08264        30     
end_path:calibanagnocchi:CalibAnaTree                  0.146493      0.651165       1.73532      0.587997      0.336179        30     
end_path:out1:RootOutput(write)                        0.277883      0.715741       1.35301      0.694598       0.22752        30     
========================================================================================================================================

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

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