justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78928.15@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3449
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 13:28:37
SiteIT_CNAF
EntryCMSHTPC_T1_IT_CNAF_condor_ce02
Last heartbeat2024-09-26 14:53:37
From worker nodeHostnamecn-leo-157.cr.cnaf.infn.it
cpuinfoIntel(R) Xeon(R) Platinum 8480+
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit216000 (60 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 13:35:00
Input fileshd-protodune:np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 14:53:37
Saved logsjustin-logs:78928.15-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

4415 potential space points
Neighbour search...
372351 tests to find 218322 neighbours
Iterating with no regularization...
Begin: 7.42724e+06
0 6.58502e+06
1 6.51999e+06
2 6.50645e+06
3 6.50166e+06
Now with regularization...
Begin: 6.01581e+06
0 6.01273e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  5   event 207623 TrkackID 2 startx, y, z 39.7171 589.01 299.7  wireno, peakt tpcno 21 39.8347 5 dist 1.7708min T, max_T17.4241 3331.87
no of hits closeby  6   event 207623 TrkackID 6 startx, y, z -77.5925 588.982 250.765  wireno, peakt tpcno 425 1606.63 6 dist 0min T, max_T1120.19 2128.64
no of hits closeby  5   event 207623 TrkackID 2 startx, y, z 39.7171 589.01 299.7  wireno, peakt tpcno 21 39.8347 5 dist 1.7708min T, max_T17.4241 3331.87
no of hits closeby  6   event 207623 TrkackID 6 startx, y, z -77.5925 588.982 250.765  wireno, peakt tpcno 425 1606.63 6 dist 0min T, max_T1120.19 2128.64
Begin processing the 29th record. run: 29107 subRun: 1 event: 207631 at 26-Sep-2024 16:50:00 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 43706 traces, 43706 summary
Retagger: tagging trace set: gauss with 33044 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 33044 traces tagged "gauss"
FrameSaver: q=685667 n=631942 tag=gauss
wclsFrameSaver: saving 43706 traces tagged "wiener"
FrameSaver: q=725870 n=570362 tag=wiener
2438 hits in TPC 0
2201 hits in TPC 1
2265 hits in TPC 2
1382 hits in TPC 3
3864 hits in TPC 4
6260 hits in TPC 5
3009 hits in TPC 6
2027 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 4 XUs and 2 XVs -> 0 XUVs
C:0 T:1 21 XUs and 11 XVs -> 1 XUVs
C:0 T:2 1933 XUs and 4352 XVs -> 82 XUVs
C:0 T:3 258 XUs and 536 XVs -> 31 XUVs
C:0 T:4 172 XUs and 230 XVs -> 15 XUVs
C:0 T:5 17186 XUs and 26765 XVs -> 652 XUVs
C:0 T:6 5931 XUs and 4146 XVs -> 153 XUVs
C:0 T:7 86 XUs and 91 XVs -> 4 XUVs
938 XUVs total
662 collection wire objects
938 potential space points
Neighbour search...
14124 tests to find 7942 neighbours
Iterating with no regularization...
Begin: 3.18868e+06
0 2.909e+06
1 2.90042e+06
2 2.89945e+06
Now with regularization...
Begin: 2.73259e+06
0 2.73222e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29107 subRun: 1 event: 207639 at 26-Sep-2024 16:51:29 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 60637 traces, 60637 summary
Retagger: tagging trace set: gauss with 44309 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 44309 traces tagged "gauss"
FrameSaver: q=958850 n=800043 tag=gauss
wclsFrameSaver: saving 60637 traces tagged "wiener"
FrameSaver: q=1.02167e+06 n=712768 tag=wiener
1240 hits in TPC 0
1779 hits in TPC 1
4064 hits in TPC 2
3497 hits in TPC 3
2446 hits in TPC 4
4178 hits in TPC 5
7264 hits in TPC 6
5689 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 312 XUs and 153 XVs -> 4 XUVs
C:0 T:2 8954 XUs and 9539 XVs -> 180 XUVs
C:0 T:3 117 XUs and 105 XVs -> 6 XUVs
C:0 T:4 20 XUs and 23 XVs -> 0 XUVs
C:0 T:5 22695 XUs and 13495 XVs -> 401 XUVs
C:0 T:6 36664 XUs and 36253 XVs -> 1202 XUVs
C:0 T:7 959 XUs and 883 XVs -> 33 XUVs
1826 XUVs total
961 collection wire objects
1826 potential space points
Neighbour search...
33964 tests to find 19768 neighbours
Iterating with no regularization...
Begin: 7.97952e+06
0 7.63619e+06
1 7.60112e+06
2 7.59704e+06
Now with regularization...
Begin: 7.13732e+06
0 7.13564e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 16:53:12 CEST  Closed output file "np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1_reco_stage2_20240926T145312_keepup.root"
26-Sep-2024 16:53:12 CEST  Closed input file "np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              82.2383       104.212       139.663       101.898       14.7617        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000565286   0.00283536     0.0118735    0.00222986    0.00238507       30     
produce:fembfilter:PDHDFEMBFilter                      0.691827      0.818871       1.02393      0.752839      0.127405        30     
produce:wclsdatahd:WireCellToolkit                      57.2319        60.67        64.3301       60.6162       1.88974        30     
produce:gaushit:GausHitFinder                          0.358737      0.564779      0.836416      0.542057      0.129014        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000397719   0.000588237   0.000785314   0.000584219   0.000114476      30     
produce:reco3d:SpacePointSolver                        0.199157       1.04305       2.41526      0.911576      0.638548        30     
produce:hitpdune:DisambigFromSpacePoints               0.146143      0.346409      0.612998      0.320101      0.135478        30     
produce:pandora:StandardPandora                         4.33946       10.0995       17.1145       10.0271       3.82464        30     
produce:pandoraWriter:StandardPandora                  0.0960808     0.168377      0.294113      0.160305      0.0464644       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.623572       2.36732       4.81485       2.10992      0.998005        30     
produce:pandoraShower:LArPandoraShowerCreation         0.597861       2.95893       6.68705       2.52575       1.48901        30     
produce:pandoracalo:Calorimetry                        0.324435      0.964981       1.84696      0.886822       0.38869        30     
produce:pandoracalonosce:Calorimetry                   0.273381      0.912543       1.86824      0.819381      0.398107        30     
produce:pandorapid:Chi2ParticleID                     0.00119716    0.00177307    0.00270579    0.00163609    0.000411324      30     
produce:pandoraShowercalo:ShowerCalorimetry             0.51707       2.3658        5.38696       1.99507       1.2548         30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.485443       2.3519        5.59246       1.94789       1.27893        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.067418      0.101148      0.168535      0.100421      0.0246013       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0261586     0.0444063     0.0716719     0.0438215     0.0115501       30     
produce:emtrkmichelid:EmTrackMichelId                   9.32091       16.3856       27.7325       16.3507       4.16583        30     
[art]:TriggerResults:TriggerResultInserter            7.2761e-05    0.000115091   0.00018343    0.00010566    2.97149e-05      30     
end_path:out1:RootOutput                              2.1785e-05    3.73487e-05   7.0298e-05    3.4579e-05    1.2617e-05       30     
end_path:michelremoving:michelremoving                 0.0338245     0.100784      0.288028      0.0842758     0.0610992       30     
end_path:michelremovinggnocchi:michelremoving          0.0203929     0.0902331     0.262186      0.0680471     0.0587793       30     
end_path:calibanagnocchi:CalibAnaTree                  0.212719      0.749226       1.38355      0.671097      0.303878        30     
end_path:out1:RootOutput(write)                        0.402062      0.682094       1.09309      0.665955      0.193642        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5835.37 MB
  Peak resident set size usage (VmHWM): 2647.52 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1_reco_stage2_20240926T145312_keepup.root
\tHists: np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1_reco_stage2_20240926T145312_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 04:00:57 UTC       justIN version: 01.01.09