justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78466.110@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 09:59:54
SiteUK_Sheffield
EntryDUNE_UK_Sheffield_lcgce1
Last heartbeat2024-09-26 12:17:13
From worker nodeHostnamewn096.hep
cpuinfoIntel(R) Xeon(R) CPU E5-2640 v4 @ 2.40GHz
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:21:45
Input fileshd-protodune:np04hd_raw_run029107_0812_dataflow3_datawriter_0_20240907T040619.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 12:17:13
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

20601 XUs and 39073 XVs -> 870 XUVs
C:0 T:3 256 XUs and 238 XVs -> 10 XUVs
C:0 T:4 3 XUs and 4 XVs -> 0 XUVs
C:0 T:5 47755 XUs and 21756 XVs -> 923 XUVs
C:0 T:6 24893 XUs and 49274 XVs -> 1580 XUVs
C:0 T:7 127 XUs and 229 XVs -> 6 XUVs
3396 XUVs total
1116 collection wire objects
3396 potential space points
Neighbour search...
179020 tests to find 92530 neighbours
Iterating with no regularization...
Begin: 8.15566e+06
0 7.51369e+06
1 7.48149e+06
2 7.47606e+06
Now with regularization...
Begin: 7.21368e+06
0 7.21156e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 195131 at 26-Sep-2024 12:53:02 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 67105 traces, 67105 summary
Retagger: tagging trace set: gauss with 49610 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 49610 traces tagged "gauss"
FrameSaver: q=1.10783e+06 n=916495 tag=gauss
wclsFrameSaver: saving 67105 traces tagged "wiener"
FrameSaver: q=1.2039e+06 n=829345 tag=wiener
5052 hits in TPC 0
4512 hits in TPC 1
4917 hits in TPC 2
3230 hits in TPC 3
2956 hits in TPC 4
4851 hits in TPC 5
6761 hits in TPC 6
3491 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 715 XUs and 670 XVs -> 44 XUVs
C:0 T:1 527 XUs and 397 XVs -> 13 XUVs
C:0 T:2 17762 XUs and 21634 XVs -> 533 XUVs
C:0 T:3 124 XUs and 138 XVs -> 5 XUVs
C:0 T:4 610 XUs and 940 XVs -> 44 XUVs
C:0 T:5 19514 XUs and 22817 XVs -> 1162 XUVs
C:0 T:6 28097 XUs and 31322 XVs -> 1612 XUVs
C:0 T:7 25 XUs and 46 XVs -> 4 XUVs
3417 XUVs total
1295 collection wire objects
3417 potential space points
Neighbour search...
268903 tests to find 143452 neighbours
Iterating with no regularization...
Begin: 1.98465e+07
0 1.81308e+07
1 1.79926e+07
2 1.79874e+07
Now with regularization...
Begin: 1.76761e+07
0 1.76746e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29107 subRun: 1 event: 195147 at 26-Sep-2024 12:55:02 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 70118 traces, 70118 summary
Retagger: tagging trace set: gauss with 53128 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 53128 traces tagged "gauss"
FrameSaver: q=1.12186e+06 n=966882 tag=gauss
wclsFrameSaver: saving 70118 traces tagged "wiener"
FrameSaver: q=1.20433e+06 n=874144 tag=wiener
4149 hits in TPC 0
3276 hits in TPC 1
5236 hits in TPC 2
2962 hits in TPC 3
5182 hits in TPC 4
6094 hits in TPC 5
5958 hits in TPC 6
3281 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 409 XUs and 194 XVs -> 3 XUVs
C:0 T:2 13026 XUs and 19319 XVs -> 2214 XUVs
C:0 T:3 33 XUs and 82 XVs -> 1 XUVs
C:0 T:4 249 XUs and 296 XVs -> 11 XUVs
C:0 T:5 30602 XUs and 27860 XVs -> 606 XUVs
C:0 T:6 17338 XUs and 13004 XVs -> 348 XUVs
C:0 T:7 40 XUs and 55 XVs -> 2 XUVs
3185 XUVs total
1083 collection wire objects
3185 potential space points
Neighbour search...
161017 tests to find 95964 neighbours
Iterating with no regularization...
Begin: 7.73308e+06
0 7.26911e+06
1 7.23582e+06
2 7.22997e+06
Now with regularization...
Begin: 6.69734e+06
0 6.69479e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 195147 TrkackID 18 startx, y, z 38.5968 466.884 28.4999  wireno, peakt tpcno 125 472.236 2 dist 130.949min T, max_T6.1394 505.215
no of hits closeby  0   event 195147 TrkackID 18 startx, y, z 38.5968 466.884 28.4999  wireno, peakt tpcno 125 472.236 2 dist 130.949min T, max_T6.1394 505.215
26-Sep-2024 12:57:13 BST  Closed output file "np04hd_raw_run029107_0812_dataflow3_datawriter_0_20240907T040619_reco_stage1_reco_stage2_20240926T115713_keepup.root"
26-Sep-2024 12:57:13 BST  Closed input file "np04hd_raw_run029107_0812_dataflow3_datawriter_0_20240907T040619_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              92.3401       126.611       225.851       119.997       25.6891        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000739092   0.00346012    0.00586518    0.00373993    0.00134903       30     
produce:fembfilter:PDHDFEMBFilter                      0.740353      0.804169      0.970511       0.77442      0.0662082       30     
produce:wclsdatahd:WireCellToolkit                      52.0416       56.9908       62.3319       56.961        2.0234         30     
produce:gaushit:GausHitFinder                          0.426547      0.827356       1.46291      0.794853       0.20359        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000316081   0.000461043   0.000722098   0.000432412   9.41361e-05      30     
produce:reco3d:SpacePointSolver                        0.326885       1.41495       3.9633        1.08463      0.966444        30     
produce:hitpdune:DisambigFromSpacePoints               0.299814      0.804184       2.55901      0.617673      0.500502        30     
produce:pandora:StandardPandora                         4.62806       17.3709       42.2814       16.0252       7.88532        30     
produce:pandoraWriter:StandardPandora                  0.116543      0.190608      0.371464       0.17703      0.0500704       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.966834       2.18824       7.42636       1.91767       1.23088        30     
produce:pandoraShower:LArPandoraShowerCreation         0.675698       2.72943       13.1985       1.97564       2.26491        30     
produce:pandoracalo:Calorimetry                         0.4677        1.01376       3.16387      0.923015      0.489103        30     
produce:pandoracalonosce:Calorimetry                   0.426218      0.942854       2.89114      0.861395      0.455635        30     
produce:pandorapid:Chi2ParticleID                     0.00151745    0.00215308    0.00379931    0.00200743    0.000526521      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.560901       2.32593       10.4765       1.81636       1.73971        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.562922       2.21423       9.74246       1.68525       1.63825        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0886913     0.152943      0.277244      0.146615      0.0394712       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0344059     0.0568711      0.1074       0.0556103     0.0148012       30     
produce:emtrkmichelid:EmTrackMichelId                   18.0279       34.6218       65.5504       33.0095       8.92909        30     
[art]:TriggerResults:TriggerResultInserter            2.3917e-05    5.27265e-05   0.000117749   5.22435e-05   1.97425e-05      30     
end_path:out1:RootOutput                               7.818e-06    1.36489e-05   6.4863e-05    1.08545e-05   1.03513e-05      30     
end_path:michelremoving:michelremoving                 0.0250337     0.0937908     0.339513      0.0598096     0.0756915       30     
end_path:michelremovinggnocchi:michelremoving          0.023772      0.0891197     0.337452      0.0562008     0.0760422       30     
end_path:calibanagnocchi:CalibAnaTree                  0.286383      0.743473       2.63618      0.649558      0.425657        30     
end_path:out1:RootOutput(write)                        0.532101      0.876873       1.65784      0.852168      0.224048        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4977.35 MB
  Peak resident set size usage (VmHWM): 2394.14 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0812_dataflow3_datawriter_0_20240907T040619_reco_stage1_reco_stage2_20240926T115713_keepup.root
\tHists: np04hd_raw_run029107_0812_dataflow3_datawriter_0_20240907T040619_reco_stage1_reco_stage2_20240926T115713_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 11:18:46 UTC       justIN version: 01.01.08