justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID79065.0@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3460
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 14:17:01
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce01
Last heartbeat2024-09-26 16:15:29
From worker nodeHostnamewn1906240.tier2.hep.manchester.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 6130 CPU @ 2.10GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 14:19:39
Input fileshd-protodune:np04hd_raw_run029218_0100_dataflow7_datawriter_0_20240917T165336.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 16:15:29
Saved logsjustin-logs:79065.0-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  3   event 25031 TrkackID 12 startx, y, z 100.205 608.249 460.57  wireno, peakt tpcno 389 3737.05 5 dist 0min T, max_T2679 4063.49
no of hits closeby  3   event 25031 TrkackID 12 startx, y, z 100.205 608.249 460.57  wireno, peakt tpcno 389 3737.05 5 dist 0min T, max_T2679 4063.49
Begin processing the 30th record. run: 29218 subRun: 1 event: 25039 at 26-Sep-2024 17:11:04 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 54896 traces, 54896 summary
Retagger: tagging trace set: gauss with 42216 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 42216 traces tagged "gauss"
FrameSaver: q=920431 n=801529 tag=gauss
wclsFrameSaver: saving 54896 traces tagged "wiener"
FrameSaver: q=979571 n=727619 tag=wiener
1697 hits in TPC 0
2055 hits in TPC 1
3322 hits in TPC 2
2815 hits in TPC 3
3619 hits in TPC 4
7449 hits in TPC 5
5161 hits in TPC 6
2975 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 279 XUs and 59 XVs -> 3 XUVs
C:0 T:2 8191 XUs and 6607 XVs -> 432 XUVs
C:0 T:3 10 XUs and 11 XVs -> 1 XUVs
C:0 T:4 121 XUs and 133 XVs -> 5 XUVs
C:0 T:5 25815 XUs and 16356 XVs -> 471 XUVs
C:0 T:6 20146 XUs and 9427 XVs -> 406 XUVs
C:0 T:7 34 XUs and 20 XVs -> 0 XUVs
1318 XUVs total
841 collection wire objects
1318 potential space points
Neighbour search...
18490 tests to find 11188 neighbours
Iterating with no regularization...
Begin: 6.09221e+06
0 5.82001e+06
1 5.80695e+06
2 5.80495e+06
Now with regularization...
Begin: 5.44034e+06
0 5.43991e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 31st record. run: 29218 subRun: 1 event: 25047 at 26-Sep-2024 17:12:59 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 68142 traces, 68142 summary
Retagger: tagging trace set: gauss with 50951 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 50951 traces tagged "gauss"
FrameSaver: q=1.18004e+06 n=959914 tag=gauss
wclsFrameSaver: saving 68142 traces tagged "wiener"
FrameSaver: q=1.25453e+06 n=867053 tag=wiener
1940 hits in TPC 0
1604 hits in TPC 1
6212 hits in TPC 2
3831 hits in TPC 3
4080 hits in TPC 4
5424 hits in TPC 5
6649 hits in TPC 6
6416 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 35 XUs and 0 XVs -> 0 XUVs
C:0 T:1 600 XUs and 273 XVs -> 18 XUVs
C:0 T:2 20431 XUs and 31131 XVs -> 928 XUVs
C:0 T:3 59 XUs and 60 XVs -> 2 XUVs
C:0 T:4 129 XUs and 152 XVs -> 2 XUVs
C:0 T:5 12625 XUs and 9771 XVs -> 418 XUVs
C:0 T:6 21670 XUs and 45270 XVs -> 1725 XUVs
C:0 T:7 164 XUs and 209 XVs -> 9 XUVs
3102 XUVs total
1563 collection wire objects
3102 potential space points
Neighbour search...
113260 tests to find 60088 neighbours
Iterating with no regularization...
Begin: 8.86467e+06
0 8.04688e+06
1 7.99406e+06
2 7.9902e+06
Now with regularization...
Begin: 7.60807e+06
0 7.60685e+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 25047 TrkackID 8 startx, y, z 15.2035 591.132 395.583  wireno, peakt tpcno 437 1526.46 5 dist 7.37667min T, max_T1468.28 2258.06
no of hits closeby  0   event 25047 TrkackID 20 startx, y, z 21.485 590.796 297.157  wireno, peakt tpcno 146 7 5 dist 0min T, max_T7 1330
no of hits closeby  5   event 25047 TrkackID 8 startx, y, z 15.2035 591.132 395.583  wireno, peakt tpcno 437 1526.46 5 dist 7.37667min T, max_T1468.28 2258.06
no of hits closeby  0   event 25047 TrkackID 20 startx, y, z 21.485 590.796 297.157  wireno, peakt tpcno 146 7 5 dist 0min T, max_T7 1330
26-Sep-2024 17:14:59 BST  Closed output file "np04hd_raw_run029218_0100_dataflow7_datawriter_0_20240917T165336_reco_stage1_reco_stage2_20240926T161459_keepup.root"
26-Sep-2024 17:14:59 BST  Closed input file "np04hd_raw_run029218_0100_dataflow7_datawriter_0_20240917T165336_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              99.1851       146.58        218.005       136.716       32.6544        31     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000727239   0.00290602    0.00477125    0.00313029    0.00112602       31     
produce:fembfilter:PDHDFEMBFilter                       0.70913       1.11896       1.60551       1.06894      0.190146        31     
produce:wclsdatahd:WireCellToolkit                      51.3134       64.7131       85.5581       64.8708       6.94579        31     
produce:gaushit:GausHitFinder                          0.550147       1.20609       2.22471       1.10833       0.38283        31     
produce:nhitsfilter:NumberOfHitsFilter                0.000329252   0.00451072     0.109778     0.000502651    0.019362        31     
produce:reco3d:SpacePointSolver                        0.194288       1.28391       7.57077      0.905219       1.34101        31     
produce:hitpdune:DisambigFromSpacePoints               0.266408      0.999248       2.15359      0.919899      0.484219        31     
produce:pandora:StandardPandora                         7.12767       18.6246       43.5598       15.2396       8.51271        31     
produce:pandoraWriter:StandardPandora                  0.121956      0.245005      0.451838      0.229067      0.0751623       31     
produce:pandoraTrack:LArPandoraTrackCreation           0.892292       2.93874       5.7707        2.57534       1.33435        31     
produce:pandoraShower:LArPandoraShowerCreation          1.10276       3.73897       8.66486       2.91238       2.18275        31     
produce:pandoracalo:Calorimetry                        0.396894       1.24212       2.55565       1.17165       0.54807        31     
produce:pandoracalonosce:Calorimetry                   0.270139       1.17098       2.47986       1.07721      0.557082        31     
produce:pandorapid:Chi2ParticleID                     0.00125321    0.00289065    0.00737334    0.00276455    0.00113441       31     
produce:pandoraShowercalo:ShowerCalorimetry            0.606187       3.14752       7.62218       2.51379       1.89993        31     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.861583       3.01317       7.10032       2.3704        1.83269        31     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0990937     0.213853       0.35169      0.215273      0.0679825       31     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0358567     0.0828857     0.142179      0.0824838     0.0281975       31     
produce:emtrkmichelid:EmTrackMichelId                   24.9978       39.9305       60.7415       37.4557       10.1342        31     
[art]:TriggerResults:TriggerResultInserter            4.6686e-05    6.7702e-05    0.000170309   6.3525e-05    2.03654e-05      31     
end_path:out1:RootOutput                              1.1924e-05    1.84421e-05   4.6385e-05     1.739e-05    6.30342e-06      31     
end_path:michelremoving:michelremoving                 0.0439697     0.196882      0.619699      0.105458      0.177553        31     
end_path:michelremovinggnocchi:michelremoving          0.0344816     0.191732      0.604127      0.105539      0.176431        31     
end_path:calibanagnocchi:CalibAnaTree                  0.386149        1.052        1.95391       1.02351      0.446247        31     
end_path:out1:RootOutput(write)                        0.651067       1.27406       2.30765       1.19771      0.337516        31     
========================================================================================================================================

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

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