justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78430.172@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3447
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:33:14
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 11:01:05
From worker nodeHostnameccwcondor0788
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:49:13
Input fileshd-protodune:np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:01:05
Saved logsjustin-logs:78430.172-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

eamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29081 subRun: 1 event: 133429 at 26-Sep-2024 12:49:46 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 48525 traces, 48525 summary
Retagger: tagging trace set: gauss with 36997 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 36997 traces tagged "gauss"
FrameSaver: q=783005 n=742419 tag=gauss
wclsFrameSaver: saving 48525 traces tagged "wiener"
FrameSaver: q=837116 n=680697 tag=wiener
4173 hits in TPC 0
3104 hits in TPC 1
4523 hits in TPC 2
2099 hits in TPC 3
3941 hits in TPC 4
6001 hits in TPC 5
2394 hits in TPC 6
1580 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 167 XUs and 120 XVs -> 5 XUVs
C:0 T:2 5514 XUs and 4278 XVs -> 276 XUVs
C:0 T:3 140 XUs and 101 XVs -> 7 XUVs
C:0 T:4 106 XUs and 225 XVs -> 9 XUVs
C:0 T:5 15146 XUs and 17562 XVs -> 898 XUVs
C:0 T:6 4171 XUs and 7804 XVs -> 204 XUVs
C:0 T:7 21 XUs and 35 XVs -> 0 XUVs
1399 XUVs total
845 collection wire objects
1399 potential space points
Neighbour search...
19443 tests to find 10886 neighbours
Iterating with no regularization...
Begin: 3.08188e+06
0 2.90807e+06
1 2.89568e+06
2 2.89523e+06
Now with regularization...
Begin: 2.55903e+06
0 2.55882e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  3   event 133429 TrkackID 0 startx, y, z 194.001 603.609 136.454  wireno, peakt tpcno 78 66.4188 5 dist 3.78333min T, max_T16.1112 3516
no of hits closeby  0   event 133429 TrkackID 6 startx, y, z 50.4289 590.484 318.169  wireno, peakt tpcno 457 4320.46 5 dist 0min T, max_T4317 5406.53
no of hits closeby  3   event 133429 TrkackID 0 startx, y, z 194.001 603.609 136.454  wireno, peakt tpcno 78 66.4188 5 dist 3.78333min T, max_T16.1112 3516
no of hits closeby  0   event 133429 TrkackID 6 startx, y, z 50.4289 590.484 318.169  wireno, peakt tpcno 457 4320.46 5 dist 0min T, max_T4317 5406.53
Begin processing the 30th record. run: 29081 subRun: 1 event: 133437 at 26-Sep-2024 12:50:53 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 52819 traces, 52819 summary
Retagger: tagging trace set: gauss with 38880 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 38880 traces tagged "gauss"
FrameSaver: q=832023 n=753216 tag=gauss
wclsFrameSaver: saving 52819 traces tagged "wiener"
FrameSaver: q=891696 n=683918 tag=wiener
3387 hits in TPC 0
3231 hits in TPC 1
6350 hits in TPC 2
2833 hits in TPC 3
3156 hits in TPC 4
3962 hits in TPC 5
3663 hits in TPC 6
2380 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1155 XUs and 3066 XVs -> 3 XUVs
C:0 T:2 18046 XUs and 25541 XVs -> 403 XUVs
C:0 T:3 857 XUs and 697 XVs -> 12 XUVs
C:0 T:4 130 XUs and 195 XVs -> 12 XUVs
C:0 T:5 24271 XUs and 25294 XVs -> 1046 XUVs
C:0 T:6 6780 XUs and 10926 XVs -> 1372 XUVs
C:0 T:7 107 XUs and 144 XVs -> 4 XUVs
2852 XUVs total
1121 collection wire objects
2852 potential space points
Neighbour search...
133130 tests to find 84310 neighbours
Iterating with no regularization...
Begin: 4.49125e+06
0 4.11913e+06
1 4.0907e+06
2 4.08623e+06
3 4.08494e+06
Now with regularization...
Begin: 3.78183e+06
0 3.78098e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 133437 TrkackID 10 startx, y, z 62.1551 596.625 90.8771  wireno, peakt tpcno 194 2042 2 dist 202.646min T, max_T162.55 2066.09
no of hits closeby  0   event 133437 TrkackID 10 startx, y, z 62.1551 596.625 90.8771  wireno, peakt tpcno 194 2042 2 dist 202.646min T, max_T162.55 2066.09
26-Sep-2024 12:52:03 CEST  Closed output file "np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236_reco_stage1_reco_stage2_20240926T105203_keepup.root"
26-Sep-2024 12:52:03 CEST  Closed input file "np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              64.5107       93.9057       136.412       92.0163       17.8792        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000544949   0.00306148    0.00464942    0.00318592    0.00107213       30     
produce:fembfilter:PDHDFEMBFilter                      0.483081      0.599046      0.764548      0.564619      0.0840248       30     
produce:wclsdatahd:WireCellToolkit                      33.134        37.8737       42.3574       38.1187       2.51129        30     
produce:gaushit:GausHitFinder                          0.406668      0.620674      0.974979       0.61602      0.138144        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000229178   0.000331364   0.000508049   0.000333353   5.93862e-05      30     
produce:reco3d:SpacePointSolver                        0.159474       1.21865       5.60356      0.992547       1.05309        30     
produce:hitpdune:DisambigFromSpacePoints               0.164728      0.460882       1.12243      0.387941       0.25403        30     
produce:pandora:StandardPandora                         4.89523       12.2752       25.3234       10.2804       5.60345        30     
produce:pandoraWriter:StandardPandora                  0.0892561     0.154927      0.246719      0.139944      0.044733        30     
produce:pandoraTrack:LArPandoraTrackCreation           0.737095       1.7713        3.57624       1.64083       0.66792        30     
produce:pandoraShower:LArPandoraShowerCreation         0.830492       2.20289       6.20598       1.75156       1.26646        30     
produce:pandoracalo:Calorimetry                        0.398921      0.868064       1.99231      0.755356      0.362906        30     
produce:pandoracalonosce:Calorimetry                   0.332697      0.771459       1.45731      0.736404      0.291798        30     
produce:pandorapid:Chi2ParticleID                     0.00129199    0.00223797    0.00727884    0.00192825    0.00128879       30     
produce:pandoraShowercalo:ShowerCalorimetry            0.701788       1.87118       4.48242       1.58214      0.922542        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.592594       1.69124       3.98898       1.42933      0.862809        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0683798     0.119381      0.200534      0.111498      0.036003        30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0245444     0.0430416     0.0687667     0.0410388     0.0124356       30     
produce:emtrkmichelid:EmTrackMichelId                   17.1928       29.666        43.7611       29.0521       6.65657        30     
[art]:TriggerResults:TriggerResultInserter            3.9965e-05    6.86177e-05   0.000148818   6.5773e-05    2.42296e-05      30     
end_path:out1:RootOutput                              1.3375e-05    1.93515e-05   3.1418e-05    1.9341e-05    4.3323e-06       30     
end_path:michelremoving:michelremoving                 0.0200277     0.0943213     0.416082      0.0578404     0.0848115       30     
end_path:michelremovinggnocchi:michelremoving          0.0191104     0.0928276     0.412107      0.0573303     0.0844827       30     
end_path:calibanagnocchi:CalibAnaTree                  0.258187      0.609338       1.77513      0.559574      0.302692        30     
end_path:out1:RootOutput(write)                        0.379782      0.671304       1.14053      0.631495      0.192616        30     
========================================================================================================================================

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

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