justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78469.32@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 10:01:18
SiteUK_Sheffield
EntryDUNE_UK_Sheffield_lcgce1
Last heartbeat2024-09-26 12:08:57
From worker nodeHostnamewn026.hep
cpuinfoIntel(R) Xeon(R) Gold 5215 CPU @ 2.50GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job stateoutputting_failed
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 10:24:21
Input fileshd-protodune:np04hd_raw_run029107_0850_dataflow3_datawriter_0_20240907T043634.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 12:08:57
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

-----------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 204251 at 26-Sep-2024 12:45:45 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 65771 traces, 65771 summary
Retagger: tagging trace set: gauss with 49309 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 49309 traces tagged "gauss"
FrameSaver: q=1.26846e+06 n=931317 tag=gauss
wclsFrameSaver: saving 65771 traces tagged "wiener"
FrameSaver: q=1.40656e+06 n=853468 tag=wiener
2007 hits in TPC 0
2631 hits in TPC 1
7792 hits in TPC 2
3975 hits in TPC 3
2767 hits in TPC 4
4406 hits in TPC 5
9505 hits in TPC 6
4317 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 125 XUs and 124 XVs -> 1 XUVs
C:0 T:2 39885 XUs and 40281 XVs -> 2104 XUVs
C:0 T:3 636 XUs and 390 XVs -> 23 XUVs
C:0 T:4 138 XUs and 151 XVs -> 7 XUVs
C:0 T:5 8559 XUs and 11175 XVs -> 1005 XUVs
C:0 T:6 140632 XUs and 141100 XVs -> 9552 XUVs
C:0 T:7 1490 XUs and 1968 XVs -> 75 XUVs
12767 XUVs total
2635 collection wire objects
12767 potential space points
Neighbour search...
1282185 tests to find 483184 neighbours
Iterating with no regularization...
Begin: 3.14698e+07
0 2.02088e+07
1 1.91576e+07
2 1.89693e+07
3 1.89016e+07
4 1.88782e+07
5 1.88661e+07
Now with regularization...
Begin: 1.77413e+07
0 1.77272e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 204251 TrkackID 2 startx, y, z 268.819 506.986 181.796  wireno, peakt tpcno 296 3401.15 2 dist 311.147min T, max_T15.9685 3435.65
no of hits closeby  0   event 204251 TrkackID 2 startx, y, z 268.819 506.986 181.796  wireno, peakt tpcno 296 3401.15 2 dist 311.147min T, max_T15.9685 3435.65
Begin processing the 30th record. run: 29107 subRun: 1 event: 204259 at 26-Sep-2024 12:47:55 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 75691 traces, 75691 summary
Retagger: tagging trace set: gauss with 55288 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 55288 traces tagged "gauss"
FrameSaver: q=1.15215e+06 n=984188 tag=gauss
wclsFrameSaver: saving 75691 traces tagged "wiener"
FrameSaver: q=1.2474e+06 n=881124 tag=wiener
2698 hits in TPC 0
3378 hits in TPC 1
10147 hits in TPC 2
3704 hits in TPC 3
2587 hits in TPC 4
5404 hits in TPC 5
7491 hits in TPC 6
3555 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 79 XUs and 43 XVs -> 0 XUVs
C:0 T:2 58225 XUs and 74510 XVs -> 3172 XUVs
C:0 T:3 332 XUs and 282 XVs -> 14 XUVs
C:0 T:4 129 XUs and 250 XVs -> 14 XUVs
C:0 T:5 18197 XUs and 15136 XVs -> 628 XUVs
C:0 T:6 36148 XUs and 42259 XVs -> 2164 XUVs
C:0 T:7 648 XUs and 743 XVs -> 41 XUVs
6033 XUVs total
1879 collection wire objects
6033 potential space points
Neighbour search...
614373 tests to find 287324 neighbours
Iterating with no regularization...
Begin: 7.31796e+06
0 6.68988e+06
1 6.63181e+06
2 6.62542e+06
Now with regularization...
Begin: 6.13485e+06
0 6.13275e+06
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  6   event 204259 TrkackID 2 startx, y, z -90.975 553.036 5.06881  wireno, peakt tpcno 464 1598.88 6 dist 0.292768min T, max_T1583.02 3478.46
no of hits closeby  6   event 204259 TrkackID 2 startx, y, z -90.975 553.036 5.06881  wireno, peakt tpcno 464 1598.88 6 dist 0.292768min T, max_T1583.02 3478.46
26-Sep-2024 12:50:15 BST  Closed output file "np04hd_raw_run029107_0850_dataflow3_datawriter_0_20240907T043634_reco_stage1_reco_stage2_20240926T115015_keepup.root"
26-Sep-2024 12:50:15 BST  Closed input file "np04hd_raw_run029107_0850_dataflow3_datawriter_0_20240907T043634_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              77.6239       109.375       166.13        106.18        20.7237        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000378515   0.00152511     0.0038724     0.0013383    0.00103602       30     
produce:fembfilter:PDHDFEMBFilter                      0.681435      0.699628      0.755018      0.693991      0.0146332       30     
produce:wclsdatahd:WireCellToolkit                      49.2088       51.9148       54.834        51.9659       1.55831        30     
produce:gaushit:GausHitFinder                           0.38774      0.755819       1.34239      0.742794      0.212038        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000261011   0.000419475   0.000663192   0.000396222   9.46081e-05      30     
produce:reco3d:SpacePointSolver                        0.189513       1.40713       5.59453      0.944886       1.38828        30     
produce:hitpdune:DisambigFromSpacePoints               0.151013      0.560944       1.23708      0.465242       0.25617        30     
produce:pandora:StandardPandora                         5.84858       13.8643       41.2204       12.8871       7.0924         30     
produce:pandoraWriter:StandardPandora                  0.0910073     0.164107       0.24166      0.157703      0.0397656       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.711482       2.52303       4.61837       2.42825       1.07857        30     
produce:pandoraShower:LArPandoraShowerCreation         0.552967       3.04711       6.7745        2.71104       1.68317        30     
produce:pandoracalo:Calorimetry                        0.314406      0.996455       1.95148      0.941062      0.414533        30     
produce:pandoracalonosce:Calorimetry                   0.291065       0.95172       1.94152      0.900704      0.428564        30     
produce:pandorapid:Chi2ParticleID                     0.00121917    0.00185689    0.00290055     0.0018021    0.000390823      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.463288       2.42656       6.16475       2.11629       1.36228        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.477138       2.40117       6.34725       2.08668       1.41782        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0702659      0.12756       0.18648      0.122228      0.0294655       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0272806     0.0515737     0.0763643     0.0502303     0.0121598       30     
produce:emtrkmichelid:EmTrackMichelId                   14.8225       25.571        39.4026       24.6154       6.12325        30     
[art]:TriggerResults:TriggerResultInserter            2.8927e-05    4.63131e-05   7.8833e-05    4.3793e-05    1.0473e-05       30     
end_path:out1:RootOutput                               8.096e-06    1.14608e-05   1.8197e-05    1.07795e-05   2.55363e-06      30     
end_path:michelremoving:michelremoving                 0.0216764     0.102164      0.380171      0.0633455     0.0823924       30     
end_path:michelremovinggnocchi:michelremoving          0.0202511     0.0979648     0.368803      0.0562955     0.0814892       30     
end_path:calibanagnocchi:CalibAnaTree                   0.21351      0.711389       1.44641      0.601591      0.316436        30     
end_path:out1:RootOutput(write)                        0.401891      0.762069       1.19433      0.736596      0.172029        30     
========================================================================================================================================

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

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