justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 263235.175@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID263235.175@justin-prod-sched01.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 09:30:31
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce03
Last heartbeat2024-09-26 10:46:58
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:32:35
Input fileshd-protodune:np04hd_raw_run029094_0123_dataflow7_datawriter_0_20240906T093325.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 10:46:58
Saved logsjustin-logs:263235.175-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

es...
C:0 T:1 131 XUs and 173 XVs -> 2 XUVs
C:0 T:2 9063 XUs and 14829 XVs -> 850 XUVs
C:0 T:3 30 XUs and 43 XVs -> 0 XUVs
C:0 T:4 1032 XUs and 894 XVs -> 47 XUVs
C:0 T:5 44143 XUs and 32981 XVs -> 1257 XUVs
C:0 T:6 17342 XUs and 6360 XVs -> 244 XUVs
C:0 T:7 93 XUs and 74 XVs -> 8 XUVs
2408 XUVs total
1378 collection wire objects
2408 potential space points
Neighbour search...
30190 tests to find 17428 neighbours
Iterating with no regularization...
Begin: 6.77549e+06
0 6.29742e+06
1 6.27583e+06
2 6.27415e+06
Now with regularization...
Begin: 5.70877e+06
0 5.70826e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29094 subRun: 1 event: 29799 at 26-Sep-2024 12:34:04 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 53807 traces, 53807 summary
Retagger: tagging trace set: gauss with 40471 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 40471 traces tagged "gauss"
FrameSaver: q=819585 n=777596 tag=gauss
wclsFrameSaver: saving 53807 traces tagged "wiener"
FrameSaver: q=883704 n=709706 tag=wiener
5962 hits in TPC 0
6575 hits in TPC 1
2188 hits in TPC 2
947 hits in TPC 3
2838 hits in TPC 4
4531 hits in TPC 5
4911 hits in TPC 6
1621 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1391 XUs and 1532 XVs -> 188 XUVs
C:0 T:2 2813 XUs and 4114 XVs -> 48 XUVs
C:0 T:3 72 XUs and 100 XVs -> 5 XUVs
C:0 T:4 98 XUs and 146 XVs -> 9 XUVs
C:0 T:5 24084 XUs and 10949 XVs -> 215 XUVs
C:0 T:6 8054 XUs and 13572 XVs -> 150 XUVs
C:0 T:7 234 XUs and 241 XVs -> 61 XUVs
676 XUVs total
373 collection wire objects
676 potential space points
Neighbour search...
10568 tests to find 7396 neighbours
Iterating with no regularization...
Begin: 1.49397e+06
0 1.44685e+06
1 1.44451e+06
2 1.44444e+06
Now with regularization...
Begin: 1.38586e+06
0 1.38585e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 29799 TrkackID 13 startx, y, z 12.1553 353.832 13.1103  wireno, peakt tpcno 34 2561.92 2 dist 290.667min T, max_T662.201 2599
no of hits closeby  0   event 29799 TrkackID 13 startx, y, z 12.1553 353.832 13.1103  wireno, peakt tpcno 34 2561.92 2 dist 290.667min T, max_T662.201 2599
Begin processing the 30th record. run: 29094 subRun: 1 event: 29807 at 26-Sep-2024 12:35:41 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 45957 traces, 45957 summary
Retagger: tagging trace set: gauss with 34652 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 34652 traces tagged "gauss"
FrameSaver: q=827399 n=688953 tag=gauss
wclsFrameSaver: saving 45957 traces tagged "wiener"
FrameSaver: q=899664 n=630829 tag=wiener
2974 hits in TPC 0
1688 hits in TPC 1
4091 hits in TPC 2
1846 hits in TPC 3
4304 hits in TPC 4
6427 hits in TPC 5
2281 hits in TPC 6
1938 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 250 XUs and 261 XVs -> 40 XUVs
C:0 T:2 16704 XUs and 7526 XVs -> 858 XUVs
C:0 T:3 27 XUs and 11 XVs -> 1 XUVs
C:0 T:4 162 XUs and 235 XVs -> 8 XUVs
C:0 T:5 24152 XUs and 56920 XVs -> 3856 XUVs
C:0 T:6 3551 XUs and 2978 XVs -> 114 XUVs
C:0 T:7 37 XUs and 38 XVs -> 6 XUVs
4883 XUVs total
1387 collection wire objects
4883 potential space points
Neighbour search...
292641 tests to find 126338 neighbours
Iterating with no regularization...
Begin: 1.10706e+07
0 8.2937e+06
1 8.06538e+06
2 8.03769e+06
3 8.03058e+06
Now with regularization...
Begin: 7.15788e+06
0 7.14925e+06
1 7.14753e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 12:37:15 CEST  Closed output file "np04hd_raw_run029094_0123_dataflow7_datawriter_0_20240906T093325_reco_stage1_reco_stage2_20240926T103715_keepup.root"
26-Sep-2024 12:37:15 CEST  Closed input file "np04hd_raw_run029094_0123_dataflow7_datawriter_0_20240906T093325_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              69.5171       96.4572       152.684       92.6621       16.637         30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000523271   0.00279098    0.00568873    0.00244999    0.00139904       30     
produce:fembfilter:PDHDFEMBFilter                      0.625438       0.73991      0.835665      0.738082      0.0514772       30     
produce:wclsdatahd:WireCellToolkit                      39.7427       45.1874       48.8476       45.8708       2.17272        30     
produce:gaushit:GausHitFinder                          0.411997      0.663409      0.941371      0.648783       0.1299         30     
produce:nhitsfilter:NumberOfHitsFilter                0.000264236   0.000393017   0.000681018   0.000367048   9.39359e-05      30     
produce:reco3d:SpacePointSolver                        0.138793      0.579704       1.64612       0.57107      0.357768        30     
produce:hitpdune:DisambigFromSpacePoints               0.168926      0.441504       1.11053      0.388651      0.200522        30     
produce:pandora:StandardPandora                         3.40227       11.0988       28.4015       10.7701       4.73244        30     
produce:pandoraWriter:StandardPandora                  0.0633335     0.150262      0.272054      0.145271      0.0465642       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.446233       1.0696        2.5748       0.939829      0.509942        30     
produce:pandoraShower:LArPandoraShowerCreation         0.382107       1.2748        4.08014       1.09847       0.82057        30     
produce:pandoracalo:Calorimetry                        0.252363      0.572967       1.42595       0.54328      0.230057        30     
produce:pandoracalonosce:Calorimetry                    0.22992      0.512506       1.31514      0.485758      0.223618        30     
produce:pandorapid:Chi2ParticleID                     0.00121205    0.00187473    0.00278154    0.00178491    0.00037773       30     
produce:pandoraShowercalo:ShowerCalorimetry            0.324953       1.18965       4.11659       1.04313       0.77569        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.316376       1.15214       4.02208      0.988974      0.726644        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0856355     0.158512      0.300243      0.150495      0.0507145       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0264944     0.0513247     0.0991855     0.0491822     0.0164422       30     
produce:emtrkmichelid:EmTrackMichelId                   15.1597       30.062        53.0436       28.3766       7.86068        30     
[art]:TriggerResults:TriggerResultInserter            1.9397e-05    3.84442e-05   0.00011705    3.0938e-05    2.10456e-05      30     
end_path:out1:RootOutput                               7.504e-06    1.00986e-05   3.4013e-05    8.8965e-06    4.70688e-06      30     
end_path:michelremoving:michelremoving                 0.0217409     0.115458      0.583834      0.0586379     0.130914        30     
end_path:michelremovinggnocchi:michelremoving          0.0193929     0.111912      0.565482      0.0557477      0.13025        30     
end_path:calibanagnocchi:CalibAnaTree                  0.183896      0.404181      0.988126      0.353307      0.168038        30     
end_path:out1:RootOutput(write)                        0.463129      0.786473       1.52247      0.732178      0.210937        30     
========================================================================================================================================

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

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