justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78430.107@justin-prod-sched02.dune.hep.ac.uk
Workflow ID3447
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:33:14
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 11:09:52
From worker nodeHostnameccwcondor0591
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 09:54:21
Input fileshd-protodune:np04hd_raw_run029081_0430_dataflow5_datawriter_0_20240904T234715.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:09:52
Saved logsjustin-logs:78430.107-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29081 subRun: 1 event: 103453 at 26-Sep-2024 12:55:44 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 73038 traces, 73038 summary
Retagger: tagging trace set: gauss with 54335 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 54335 traces tagged "gauss"
FrameSaver: q=1.11325e+06 n=1009629 tag=gauss
wclsFrameSaver: saving 73038 traces tagged "wiener"
FrameSaver: q=1.20134e+06 n=917111 tag=wiener
3992 hits in TPC 0
4525 hits in TPC 1
7385 hits in TPC 2
2820 hits in TPC 3
4080 hits in TPC 4
5576 hits in TPC 5
6152 hits in TPC 6
4014 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 774 XUs and 573 XVs -> 22 XUVs
C:0 T:2 22130 XUs and 52583 XVs -> 320 XUVs
C:0 T:3 20 XUs and 20 XVs -> 0 XUVs
C:0 T:4 155 XUs and 185 XVs -> 3 XUVs
C:0 T:5 12673 XUs and 19480 XVs -> 461 XUVs
C:0 T:6 54816 XUs and 77386 XVs -> 3836 XUVs
C:0 T:7 1500 XUs and 1044 XVs -> 22 XUVs
4664 XUVs total
1569 collection wire objects
4664 potential space points
Neighbour search...
360452 tests to find 149290 neighbours
Iterating with no regularization...
Begin: 1.0666e+07
0 8.48485e+06
1 8.35603e+06
2 8.33278e+06
3 8.32778e+06
Now with regularization...
Begin: 7.95656e+06
0 7.95341e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 103453 TrkackID 1 startx, y, z -52.3265 424.75 445.751  wireno, peakt tpcno 7 391.689 2 dist 0min T, max_T385.126 1902.89
no of hits closeby  0   event 103453 TrkackID 10 startx, y, z -184.226 266.56 134.975  wireno, peakt tpcno 218 1004 2 dist 0min T, max_T6.4911 2352.07
no of hits closeby  0   event 103453 TrkackID 1 startx, y, z -52.3265 424.75 445.751  wireno, peakt tpcno 7 391.689 2 dist 0min T, max_T385.126 1902.89
no of hits closeby  0   event 103453 TrkackID 10 startx, y, z -184.226 266.56 134.975  wireno, peakt tpcno 218 1004 2 dist 0min T, max_T6.4911 2352.07
Begin processing the 30th record. run: 29081 subRun: 1 event: 103461 at 26-Sep-2024 12:57:36 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 80851 traces, 80851 summary
Retagger: tagging trace set: gauss with 58533 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 58533 traces tagged "gauss"
FrameSaver: q=1.21486e+06 n=1047107 tag=gauss
wclsFrameSaver: saving 80851 traces tagged "wiener"
FrameSaver: q=1.3136e+06 n=935253 tag=wiener
4537 hits in TPC 0
4096 hits in TPC 1
9856 hits in TPC 2
4007 hits in TPC 3
4188 hits in TPC 4
7482 hits in TPC 5
4313 hits in TPC 6
2895 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 4639 XUs and 2949 XVs -> 123 XUVs
C:0 T:2 43614 XUs and 60273 XVs -> 1927 XUVs
C:0 T:3 15 XUs and 22 XVs -> 1 XUVs
C:0 T:4 54 XUs and 88 XVs -> 3 XUVs
C:0 T:5 35014 XUs and 35851 XVs -> 1133 XUVs
C:0 T:6 38490 XUs and 79352 XVs -> 4395 XUVs
C:0 T:7 69 XUs and 51 XVs -> 7 XUVs
7589 XUVs total
1766 collection wire objects
7589 potential space points
Neighbour search...
1420193 tests to find 592168 neighbours
Iterating with no regularization...
Begin: 8.49611e+06
0 7.7073e+06
1 7.65177e+06
2 7.64292e+06
3 7.64022e+06
Now with regularization...
Begin: 7.22297e+06
0 7.22116e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 103461 TrkackID 17 startx, y, z 41.7507 480.456 9.98876  wireno, peakt tpcno 105 2318.97 2 dist 136.811min T, max_T1346.17 2352.57
no of hits closeby  0   event 103461 TrkackID 17 startx, y, z 41.7507 480.456 9.98876  wireno, peakt tpcno 105 2318.97 2 dist 136.811min T, max_T1346.17 2352.57
26-Sep-2024 12:59:33 CEST  Closed output file "np04hd_raw_run029081_0430_dataflow5_datawriter_0_20240904T234715_reco_stage1_reco_stage2_20240926T105933_keepup.root"
26-Sep-2024 12:59:33 CEST  Closed input file "np04hd_raw_run029081_0430_dataflow5_datawriter_0_20240904T234715_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              63.888        98.0806       172.189       98.2875       21.3516        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.00050802    0.00298899    0.00666277    0.00281236    0.00143559       30     
produce:fembfilter:PDHDFEMBFilter                      0.505378      0.665665      0.771863      0.679438      0.0704879       30     
produce:wclsdatahd:WireCellToolkit                      35.1604       38.9309       44.4072       38.2634       2.83971        30     
produce:gaushit:GausHitFinder                          0.472704      0.728617       1.18725      0.741812      0.164677        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000216626   0.000367255   0.000653944   0.000360981   9.03647e-05      30     
produce:reco3d:SpacePointSolver                        0.301016       1.52001       3.79087       1.18224       1.08612        30     
produce:hitpdune:DisambigFromSpacePoints               0.210376       0.56073       1.66808      0.447801       0.32516        30     
produce:pandora:StandardPandora                         5.97707       13.2755       34.7584       11.7348       6.35839        30     
produce:pandoraWriter:StandardPandora                  0.0752642     0.161109      0.294713       0.16805      0.0471148       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.567463       1.91258       4.32864       2.07352      0.806702        30     
produce:pandoraShower:LArPandoraShowerCreation          0.5687        2.55331       8.55409       2.55959       1.48924        30     
produce:pandoracalo:Calorimetry                        0.287559      0.919512       2.31381      0.880579       0.40107        30     
produce:pandoracalonosce:Calorimetry                   0.367221      0.844961       2.3718       0.821558      0.382917        30     
produce:pandorapid:Chi2ParticleID                     0.00120293    0.00210401    0.00310411    0.00194908    0.000525792      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.688499       2.22259       8.31043       2.00316       1.3889         30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.585814       2.1484        7.94979       2.02132       1.31563        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0757356     0.148845      0.247046      0.157346      0.045889        30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0265879     0.0548711     0.0999654     0.0544423     0.0177633       30     
produce:emtrkmichelid:EmTrackMichelId                   15.4723       29.524        50.5949       30.8211       7.51957        30     
[art]:TriggerResults:TriggerResultInserter            4.1027e-05    7.24436e-05   0.000146915   7.1459e-05    1.89007e-05      30     
end_path:out1:RootOutput                               8.767e-06    1.9002e-05    4.6698e-05    1.81935e-05   6.93571e-06      30     
end_path:michelremoving:michelremoving                 0.0262244     0.122435      0.346648      0.0816171     0.0935981       30     
end_path:michelremovinggnocchi:michelremoving          0.0220617     0.109798      0.367784      0.0717629     0.0856493       30     
end_path:calibanagnocchi:CalibAnaTree                   0.20184      0.688778       1.45334       0.65261      0.285542        30     
end_path:out1:RootOutput(write)                        0.457913      0.752549       1.22994      0.733553      0.179829        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4953.45 MB
  Peak resident set size usage (VmHWM): 2381.27 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_0430_dataflow5_datawriter_0_20240904T234715_reco_stage1_reco_stage2_20240926T105933_keepup.root
\tHists: np04hd_raw_run029081_0430_dataflow5_datawriter_0_20240904T234715_reco_stage1_reco_stage2_20240926T105933_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 05:59:02 UTC       justIN version: 01.01.09