justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263295.8@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3453
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:58:35
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce01
Last heartbeat2024-09-26 11:26:10
From worker nodeHostnameccwcondor0588
cpuinfoAMD EPYC 7453 28-Core Processor
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit106200 (29 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 10:03:01
Input fileshd-protodune:np04hd_raw_run029107_3655_dataflow1_datawriter_0_20240909T044545.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:26:10
Saved logsjustin-logs:263295.8-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

eighbour search...
55927 tests to find 33156 neighbours
Iterating with no regularization...
Begin: 5.69985e+06
0 5.094e+06
1 5.05206e+06
2 5.04464e+06
3 5.04267e+06
Now with regularization...
Begin: 4.6792e+06
0 4.67827e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 877449 at 26-Sep-2024 13:06:11 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 57486 traces, 57486 summary
Retagger: tagging trace set: gauss with 42109 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 42109 traces tagged "gauss"
FrameSaver: q=963114 n=800051 tag=gauss
wclsFrameSaver: saving 57486 traces tagged "wiener"
FrameSaver: q=1.04803e+06 n=734184 tag=wiener
1640 hits in TPC 0
1643 hits in TPC 1
3947 hits in TPC 2
2564 hits in TPC 3
4881 hits in TPC 4
6448 hits in TPC 5
6938 hits in TPC 6
4098 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 382 XUs and 52 XVs -> 0 XUVs
C:0 T:2 10309 XUs and 9950 XVs -> 347 XUVs
C:0 T:3 241 XUs and 252 XVs -> 10 XUVs
C:0 T:4 297 XUs and 376 XVs -> 22 XUVs
C:0 T:5 21974 XUs and 19442 XVs -> 992 XUVs
C:0 T:6 25029 XUs and 32058 XVs -> 2968 XUVs
C:0 T:7 458 XUs and 257 XVs -> 19 XUVs
4358 XUVs total
1378 collection wire objects
4358 potential space points
Neighbour search...
335540 tests to find 193286 neighbours
Iterating with no regularization...
Begin: 8.34313e+06
0 7.69664e+06
1 7.6541e+06
2 7.64663e+06
Now with regularization...
Begin: 7.1961e+06
0 7.19182e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 877449 TrkackID 0 startx, y, z 241.631 486.543 461.201  wireno, peakt tpcno 404 532.323 5 dist 1.901min T, max_T498 4907.33
no of hits closeby  0   event 877449 TrkackID 0 startx, y, z 241.631 486.543 461.201  wireno, peakt tpcno 404 532.323 5 dist 1.901min T, max_T498 4907.33
Begin processing the 30th record. run: 29107 subRun: 1 event: 877457 at 26-Sep-2024 13:07:31 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 64148 traces, 64148 summary
Retagger: tagging trace set: gauss with 48106 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 48106 traces tagged "gauss"
FrameSaver: q=1.08491e+06 n=893361 tag=gauss
wclsFrameSaver: saving 64148 traces tagged "wiener"
FrameSaver: q=1.16738e+06 n=810256 tag=wiener
3829 hits in TPC 0
3851 hits in TPC 1
4874 hits in TPC 2
2772 hits in TPC 3
3574 hits in TPC 4
5046 hits in TPC 5
5646 hits in TPC 6
3746 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 11 XUs and 10 XVs -> 0 XUVs
C:0 T:1 241 XUs and 496 XVs -> 2 XUVs
C:0 T:2 9788 XUs and 7769 XVs -> 430 XUVs
C:0 T:3 145 XUs and 326 XVs -> 14 XUVs
C:0 T:4 139 XUs and 151 XVs -> 8 XUVs
C:0 T:5 10305 XUs and 13947 XVs -> 1815 XUVs
C:0 T:6 23865 XUs and 13891 XVs -> 250 XUVs
C:0 T:7 113 XUs and 156 XVs -> 8 XUVs
2527 XUVs total
786 collection wire objects
2527 potential space points
Neighbour search...
136181 tests to find 79284 neighbours
Iterating with no regularization...
Begin: 5.03894e+08
0 5.0008e+08
1 4.99362e+08
2 4.99351e+08
Now with regularization...
Begin: 4.98992e+08
0 4.98988e+08
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  11   event 877457 TrkackID 1 startx, y, z 126.776 439.843 450.138  wireno, peakt tpcno 10 1447.63 5 dist 4.1051min T, max_T79.9673 1841.58
no of hits closeby  11   event 877457 TrkackID 1 startx, y, z 126.776 439.843 450.138  wireno, peakt tpcno 10 1447.63 5 dist 4.1051min T, max_T79.9673 1841.58
26-Sep-2024 13:08:48 CEST  Closed output file "np04hd_raw_run029107_3655_dataflow1_datawriter_0_20240909T044545_reco_stage1_reco_stage2_20240926T110848_keepup.root"
26-Sep-2024 13:08:48 CEST  Closed input file "np04hd_raw_run029107_3655_dataflow1_datawriter_0_20240909T044545_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              56.1593       94.1664       175.076       90.8326       22.9689        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000597237   0.00271239    0.00443535     0.0029206    0.00109751       30     
produce:fembfilter:PDHDFEMBFilter                      0.494416      0.675858      0.797274      0.703269      0.0848678       30     
produce:wclsdatahd:WireCellToolkit                      31.719        40.2955       46.5124       40.789        4.26847        30     
produce:gaushit:GausHitFinder                          0.330763      0.681247       1.33105      0.615659      0.226993        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000231522   0.000321171   0.000472623   0.000284246   7.04381e-05      30     
produce:reco3d:SpacePointSolver                        0.211414       1.14687       6.59182      0.678895       1.35397        30     
produce:hitpdune:DisambigFromSpacePoints                0.15181      0.509603       1.41612      0.441557      0.292364        30     
produce:pandora:StandardPandora                         4.92527       12.2839       55.3009       10.0333       9.06006        30     
produce:pandoraWriter:StandardPandora                  0.0726093     0.147713      0.263434      0.145507      0.0433716       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.475874       1.43197       3.19194       1.27476      0.702627        30     
produce:pandoraShower:LArPandoraShowerCreation         0.307012       1.59634       4.1454        1.39182      0.899223        30     
produce:pandoracalo:Calorimetry                         0.23061      0.695852       1.39805      0.661621      0.283389        30     
produce:pandoracalonosce:Calorimetry                   0.208535      0.614657       1.24691      0.601799      0.260043        30     
produce:pandorapid:Chi2ParticleID                     0.00114836    0.00200522    0.00355749    0.00194796    0.000606733      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.242615       1.4586        3.52874       1.32153      0.794874        30     
produce:pandoraShowercalonosce:ShowerCalorimetry        0.23786       1.35497       3.33781       1.30895      0.729956        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0518524     0.135975      0.256929      0.138079      0.0475046       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0190663     0.0486287     0.0945707     0.0530856     0.017486        30     
produce:emtrkmichelid:EmTrackMichelId                   15.6588       29.5429       47.6216       29.918        7.12633        30     
[art]:TriggerResults:TriggerResultInserter            2.2662e-05    5.47542e-05   9.8794e-05     5.349e-05    2.16097e-05      30     
end_path:out1:RootOutput                               8.666e-06    1.71868e-05    3.781e-05    1.6391e-05    6.89227e-06      30     
end_path:michelremoving:michelremoving                 0.0146996     0.0714824     0.222979      0.0486327     0.0566007       30     
end_path:michelremovinggnocchi:michelremoving          0.0140849     0.068386      0.249601      0.0435358     0.0581003       30     
end_path:calibanagnocchi:CalibAnaTree                  0.156903      0.485994      0.951748      0.465364      0.206466        30     
end_path:out1:RootOutput(write)                        0.310222      0.734881       1.1446       0.729443      0.188803        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4936.72 MB
  Peak resident set size usage (VmHWM): 2353.75 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_3655_dataflow1_datawriter_0_20240909T044545_reco_stage1_reco_stage2_20240926T110848_keepup.root
\tHists: np04hd_raw_run029107_3655_dataflow1_datawriter_0_20240909T044545_reco_stage1_reco_stage2_20240926T110848_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 09:25:55 UTC       justIN version: 01.01.08