justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263940.68@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 14:25:09
SiteUK_Brunel
EntryCMSHTPC_T2_UK_London_Brunel_dc2_22
Last heartbeat2024-09-26 17:10:26
From worker nodeHostnamewn-b7-04-00.brunel.ac.uk
cpuinfoIntel(R) Xeon(R) CPU E5645 @ 2.40GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit171000 (47 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 14:27:27
Input fileshd-protodune:np04hd_raw_run029092_0926_dataflow6_datawriter_0_20240906T075019.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 17:10:26
Saved logsjustin-logs:263940.68-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

o calculate correlation coefficient p-value for these numbers
----view 0: 0.0254998 0.020339 0.0189803 0.0212226 0.0177534 0.0218382 0.0222437 0.0209337 0.0187774 0.0239586 0.0196226 
----view 1: 0.000287175 0.000287175 0.000287175 0.000287116 0.000287175 0.000287175 0.000287175 0.000287175 0.000287175 0.000287175 0.000287116 
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29092 subRun: 1 event: 222470 at 26-Sep-2024 18:01:23 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 55315 traces, 55315 summary
Retagger: tagging trace set: gauss with 40465 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 40465 traces tagged "gauss"
FrameSaver: q=863073 n=774444 tag=gauss
wclsFrameSaver: saving 55315 traces tagged "wiener"
FrameSaver: q=931526 n=705338 tag=wiener
4932 hits in TPC 0
3070 hits in TPC 1
7527 hits in TPC 2
5703 hits in TPC 3
2623 hits in TPC 4
3600 hits in TPC 5
2450 hits in TPC 6
1184 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 9 XUs and 2 XVs -> 0 XUVs
C:0 T:1 1689 XUs and 1237 XVs -> 20 XUVs
C:0 T:2 22722 XUs and 39458 XVs -> 1713 XUVs
C:0 T:3 234 XUs and 523 XVs -> 12 XUVs
C:0 T:4 109 XUs and 74 XVs -> 1 XUVs
C:0 T:5 14727 XUs and 14254 XVs -> 595 XUVs
C:0 T:6 1793 XUs and 3065 XVs -> 115 XUVs
C:0 T:7 18 XUs and 27 XVs -> 1 XUVs
2457 XUVs total
1268 collection wire objects
2457 potential space points
Neighbour search...
60593 tests to find 36770 neighbours
Iterating with no regularization...
Begin: 6.44001e+06
0 5.79874e+06
1 5.75847e+06
2 5.75173e+06
3 5.75008e+06
Now with regularization...
Begin: 5.29152e+06
0 5.29057e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29092 subRun: 1 event: 222478 at 26-Sep-2024 18:05:17 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 52532 traces, 52532 summary
Retagger: tagging trace set: gauss with 40346 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 40346 traces tagged "gauss"
FrameSaver: q=900855 n=815675 tag=gauss
wclsFrameSaver: saving 52532 traces tagged "wiener"
FrameSaver: q=947672 n=743198 tag=wiener
2216 hits in TPC 0
1744 hits in TPC 1
6807 hits in TPC 2
5505 hits in TPC 3
1396 hits in TPC 4
3445 hits in TPC 5
5248 hits in TPC 6
3524 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 52 XUs and 61 XVs -> 0 XUVs
C:0 T:2 24360 XUs and 24841 XVs -> 642 XUVs
C:0 T:3 926 XUs and 854 XVs -> 30 XUVs
C:0 T:4 17 XUs and 16 XVs -> 1 XUVs
C:0 T:5 8166 XUs and 5092 XVs -> 128 XUVs
C:0 T:6 14428 XUs and 13644 XVs -> 383 XUVs
C:0 T:7 306 XUs and 391 XVs -> 6 XUVs
1190 XUVs total
873 collection wire objects
1190 potential space points
Neighbour search...
15178 tests to find 7986 neighbours
Iterating with no regularization...
Begin: 6.06777e+06
0 5.85081e+06
1 5.84457e+06
2 5.84422e+06
Now with regularization...
Begin: 5.53478e+06
0 5.53458e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  4   event 222478 TrkackID 0 startx, y, z 71.3841 600.844 41.8833  wireno, peakt tpcno 458 5239.63 5 dist 0min T, max_T4934.21 5855.52
no of hits closeby  0   event 222478 TrkackID 2 startx, y, z -218.131 503.838 220.647  wireno, peakt tpcno 27 2454.78 2 dist 0min T, max_T5.47683 2794.89
no of hits closeby  4   event 222478 TrkackID 0 startx, y, z 71.3841 600.844 41.8833  wireno, peakt tpcno 458 5239.63 5 dist 0min T, max_T4934.21 5855.52
no of hits closeby  0   event 222478 TrkackID 2 startx, y, z -218.131 503.838 220.647  wireno, peakt tpcno 27 2454.78 2 dist 0min T, max_T5.47683 2794.89
26-Sep-2024 18:09:36 BST  Closed output file "np04hd_raw_run029092_0926_dataflow6_datawriter_0_20240906T075019_reco_stage1_reco_stage2_20240926T170936_keepup.root"
26-Sep-2024 18:09:36 BST  Closed input file "np04hd_raw_run029092_0926_dataflow6_datawriter_0_20240906T075019_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              148.419       225.843       398.519       222.978       51.3322        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000484787   0.00334572     0.0282043    0.00266568    0.00473419       30     
produce:fembfilter:PDHDFEMBFilter                      0.855724       1.07269       1.85654      0.901024      0.291108        30     
produce:wclsdatahd:WireCellToolkit                      66.7667       76.3371       101.518       74.4149       9.06465        30     
produce:gaushit:GausHitFinder                          0.875695       1.35994       2.32094       1.28417      0.351081        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000437746   0.000603649   0.000870084   0.000591995   0.000119202      30     
produce:reco3d:SpacePointSolver                        0.231658       1.37933       3.72675       1.2606       0.881648        30     
produce:hitpdune:DisambigFromSpacePoints               0.315171       1.16683       3.53286       1.04406      0.657946        30     
produce:pandora:StandardPandora                         10.7926       24.7233       82.8344       20.9906       14.1018        30     
produce:pandoraWriter:StandardPandora                  0.130276      0.217044      0.486153      0.207977      0.0669902       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.757256       2.28282       6.18306       2.03095       1.16886        30     
produce:pandoraShower:LArPandoraShowerCreation          0.89055       2.56081       7.19878       2.25144       1.52301        30     
produce:pandoracalo:Calorimetry                        0.424784       1.11763       2.84925       1.04997      0.512764        30     
produce:pandoracalonosce:Calorimetry                   0.373523       1.0163        2.62918      0.928229      0.478888        30     
produce:pandorapid:Chi2ParticleID                     0.00185067     0.0051534     0.0672781    0.00276604     0.0115742       30     
produce:pandoraShowercalo:ShowerCalorimetry            0.743801       2.2541        6.43657       2.00989       1.34736        30     
produce:pandoraShowercalonosce:ShowerCalorimetry        0.72855       2.21111       6.19329       2.00709       1.28864        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.109832      0.226717      0.576246      0.216439      0.0829153       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.039057      0.0799556     0.211607      0.0745414     0.0302327       30     
produce:emtrkmichelid:EmTrackMichelId                   61.0188       104.783       207.006       99.8769       30.1077        30     
[art]:TriggerResults:TriggerResultInserter            2.5853e-05    4.01693e-05   9.3876e-05    3.70835e-05   1.30803e-05      30     
end_path:out1:RootOutput                               8.881e-06    0.000154632    0.0043133    1.0596e-05    0.000772252      30     
end_path:michelremoving:michelremoving                 0.0269175      0.34955       1.48128      0.0758757      0.39666        30     
end_path:michelremovinggnocchi:michelremoving          0.0245774     0.333311       1.47548      0.0525363     0.395104        30     
end_path:calibanagnocchi:CalibAnaTree                   0.34045      0.836131       1.94456      0.760109      0.324847        30     
end_path:out1:RootOutput(write)                        0.763271       1.23075       1.88357       1.20709      0.266161        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4941.99 MB
  Peak resident set size usage (VmHWM): 2596.7 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029092_0926_dataflow6_datawriter_0_20240906T075019_reco_stage1_reco_stage2_20240926T170936_keepup.root
\tHists: np04hd_raw_run029092_0926_dataflow6_datawriter_0_20240906T075019_reco_stage1_reco_stage2_20240926T170936_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 03:16:24 UTC       justIN version: 01.01.09