justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78497.86@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 10:12:31
SiteIT_CNAF
EntryCMSHTPC_T1_IT_CNAF_condor_ce02
Last heartbeat2024-09-26 12:28:02
From worker nodeHostnamecn-leo-116.cr.cnaf.infn.it
cpuinfoIntel(R) Xeon(R) Platinum 8480+
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit216000 (60 hours)
Inner Apptainer?True
Job stateoutputting_failed
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 10:47:07
Input fileshd-protodune:np04hd_raw_run029092_0299_dataflow4_datawriter_0_20240905T212504.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 12:28:02
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

d 11753 XVs -> 443 XUVs
C:0 T:7 86 XUs and 119 XVs -> 2 XUVs
2228 XUVs total
1322 collection wire objects
2228 potential space points
Neighbour search...
30810 tests to find 18982 neighbours
Iterating with no regularization...
Begin: 1.01037e+07
0 9.73246e+06
1 9.70752e+06
2 9.70543e+06
Now with regularization...
Begin: 9.14831e+06
0 9.1476e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29092 subRun: 1 event: 72036 at 26-Sep-2024 13:56:29 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 76385 traces, 76385 summary
Retagger: tagging trace set: gauss with 55747 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 55747 traces tagged "gauss"
FrameSaver: q=1.1875e+06 n=1037969 tag=gauss
wclsFrameSaver: saving 76385 traces tagged "wiener"
FrameSaver: q=1.27223e+06 n=932346 tag=wiener
3232 hits in TPC 0
3824 hits in TPC 1
6007 hits in TPC 2
3603 hits in TPC 3
6966 hits in TPC 4
10324 hits in TPC 5
4470 hits in TPC 6
1797 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 207 XUs and 327 XVs -> 87 XUVs
C:0 T:2 20021 XUs and 30043 XVs -> 687 XUVs
C:0 T:3 98 XUs and 145 XVs -> 3 XUVs
C:0 T:4 704 XUs and 661 XVs -> 17 XUVs
C:0 T:5 74406 XUs and 59121 XVs -> 2130 XUVs
C:0 T:6 8844 XUs and 14479 XVs -> 262 XUVs
C:0 T:7 34 XUs and 50 XVs -> 3 XUVs
3189 XUVs total
1637 collection wire objects
3189 potential space points
Neighbour search...
93105 tests to find 51268 neighbours
Iterating with no regularization...
Begin: 1.03978e+07
0 9.87105e+06
1 9.83986e+06
2 9.83543e+06
Now with regularization...
Begin: 9.31812e+06
0 9.31643e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29092 subRun: 1 event: 72044 at 26-Sep-2024 13:58:21 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 39050 traces, 39050 summary
Retagger: tagging trace set: gauss with 28698 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 28698 traces tagged "gauss"
FrameSaver: q=568887 n=519915 tag=gauss
wclsFrameSaver: saving 39050 traces tagged "wiener"
FrameSaver: q=614512 n=467139 tag=wiener
2178 hits in TPC 0
1818 hits in TPC 1
3405 hits in TPC 2
642 hits in TPC 3
1394 hits in TPC 4
3586 hits in TPC 5
4448 hits in TPC 6
3139 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 147 XUs and 150 XVs -> 22 XUVs
C:0 T:2 7429 XUs and 27013 XVs -> 324 XUVs
C:0 T:3 45 XUs and 59 XVs -> 5 XUVs
C:0 T:4 22 XUs and 45 XVs -> 6 XUVs
C:0 T:5 11857 XUs and 10840 XVs -> 127 XUVs
C:0 T:6 9489 XUs and 10123 XVs -> 396 XUVs
C:0 T:7 108 XUs and 110 XVs -> 13 XUVs
893 XUVs total
545 collection wire objects
893 potential space points
Neighbour search...
20527 tests to find 13594 neighbours
Iterating with no regularization...
Begin: 2.66904e+06
0 2.54633e+06
1 2.54228e+06
2 2.54152e+06
Now with regularization...
Begin: 2.33854e+06
0 2.33833e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 72044 TrkackID 1 startx, y, z -41.7369 588.92 194.934  wireno, peakt tpcno 446 4091.05 6 dist 0.661428min T, max_T4090.2 4683.47
no of hits closeby  0   event 72044 TrkackID 1 startx, y, z -41.7369 588.92 194.934  wireno, peakt tpcno 446 4091.05 6 dist 0.661428min T, max_T4090.2 4683.47
26-Sep-2024 13:59:43 CEST  Closed output file "np04hd_raw_run029092_0299_dataflow4_datawriter_0_20240905T212504_reco_stage1_reco_stage2_20240926T115943_keepup.root"
26-Sep-2024 13:59:43 CEST  Closed input file "np04hd_raw_run029092_0299_dataflow4_datawriter_0_20240905T212504_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              79.5748       102.688       138.769       102.961       14.629         30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000506418   0.00215612    0.00683177    0.00123105    0.00185711       30     
produce:fembfilter:PDHDFEMBFilter                      0.695884       0.72352      0.817467      0.717304      0.0226168       30     
produce:wclsdatahd:WireCellToolkit                      59.0247       61.7038       65.1691       61.5914       1.51808        30     
produce:gaushit:GausHitFinder                          0.334218      0.566876       0.8115        0.55442      0.129129        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000295996   0.000533279   0.000801466   0.00050832    0.000128162      30     
produce:reco3d:SpacePointSolver                        0.169821      0.919277       3.31666      0.781937      0.700775        30     
produce:hitpdune:DisambigFromSpacePoints               0.0948178     0.382645      0.860225      0.388911      0.173837        30     
produce:pandora:StandardPandora                         3.5565        10.4271       19.864        9.68204       4.42152        30     
produce:pandoraWriter:StandardPandora                  0.100179      0.165563      0.246316      0.157649      0.0381591       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.995845       2.5546        4.95951       2.32231       1.0663         30     
produce:pandoraShower:LArPandoraShowerCreation          1.17354       3.17259       8.27596       2.77728       1.58577        30     
produce:pandoracalo:Calorimetry                        0.418544       1.00634       2.35372      0.934356      0.425234        30     
produce:pandoracalonosce:Calorimetry                   0.382032      0.936367       1.90239      0.884259      0.380432        30     
produce:pandorapid:Chi2ParticleID                     0.00113688    0.00167244    0.00310393    0.00166766    0.000366735      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.751088       2.47935       7.09943       2.21497       1.35113        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.736595       2.41861       6.47832       2.14797       1.27973        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0543031     0.102094      0.161555      0.0992012     0.0262623       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0270043     0.0447566     0.0715146     0.0448105     0.0110949       30     
produce:emtrkmichelid:EmTrackMichelId                   7.78725       13.2088       19.3633       12.4679       2.93135        30     
[art]:TriggerResults:TriggerResultInserter            4.6526e-05    6.99685e-05   0.000113948   6.6584e-05    1.24426e-05      30     
end_path:out1:RootOutput                              1.0912e-05    1.81188e-05   2.8486e-05    1.80335e-05   3.19537e-06      30     
end_path:michelremoving:michelremoving                 0.027117      0.0728968     0.164661      0.0556603     0.0385455       30     
end_path:michelremovinggnocchi:michelremoving          0.0235828     0.069865      0.169916      0.0532002     0.0392733       30     
end_path:calibanagnocchi:CalibAnaTree                   0.26014      0.701792       1.35819      0.654203      0.286706        30     
end_path:out1:RootOutput(write)                        0.354124       0.64041       1.04842      0.632562      0.163392        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 6044.72 MB
  Peak resident set size usage (VmHWM): 2750.82 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029092_0299_dataflow4_datawriter_0_20240905T212504_reco_stage1_reco_stage2_20240926T115943_keepup.root
\tHists: np04hd_raw_run029092_0299_dataflow4_datawriter_0_20240905T212504_reco_stage1_reco_stage2_20240926T115943_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:36:58 UTC       justIN version: 01.01.08