justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID263293.104@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3450
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:26
SiteFR_CCIN2P3
EntryDUNE_FR_CCIN2P3_cccondorce02
Last heartbeat2024-09-26 11:16:16
From worker nodeHostnameccwcondor0643.in2p3.fr
cpuinfoAMD EPYC 7302 16-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:01:46
Input fileshd-protodune:np04hd_raw_run029107_1515_dataflow0_datawriter_0_20240907T165146.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 11:16:16
Saved logsjustin-logs:263293.104-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

TPC 0
2199 hits in TPC 1
6727 hits in TPC 2
2819 hits in TPC 3
2542 hits in TPC 4
3873 hits in TPC 5
7235 hits in TPC 6
3301 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 734 XUs and 199 XVs -> 1 XUVs
C:0 T:2 75077 XUs and 84591 XVs -> 2361 XUVs
C:0 T:3 31 XUs and 23 XVs -> 0 XUVs
C:0 T:4 265 XUs and 461 XVs -> 29 XUVs
C:0 T:5 11428 XUs and 8978 XVs -> 409 XUVs
C:0 T:6 51211 XUs and 50132 XVs -> 1386 XUVs
C:0 T:7 236 XUs and 389 XVs -> 4 XUVs
4190 XUVs total
1395 collection wire objects
4190 potential space points
Neighbour search...
233972 tests to find 138346 neighbours
Iterating with no regularization...
Begin: 7.50112e+06
0 6.93318e+06
1 6.89628e+06
2 6.88981e+06
Now with regularization...
Begin: 6.60308e+06
0 6.60023e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29107 subRun: 1 event: 363864 at 26-Sep-2024 13:02:46 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 81903 traces, 81903 summary
Retagger: tagging trace set: gauss with 57782 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 57782 traces tagged "gauss"
FrameSaver: q=1.30905e+06 n=1010289 tag=gauss
wclsFrameSaver: saving 81903 traces tagged "wiener"
FrameSaver: q=1.42287e+06 n=897463 tag=wiener
1995 hits in TPC 0
1745 hits in TPC 1
10323 hits in TPC 2
6597 hits in TPC 3
3347 hits in TPC 4
5103 hits in TPC 5
8584 hits in TPC 6
3782 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1309 XUs and 1327 XVs -> 289 XUVs
C:0 T:2 85128 XUs and 79349 XVs -> 1856 XUVs
C:0 T:3 183 XUs and 221 XVs -> 7 XUVs
C:0 T:4 34 XUs and 19 XVs -> 1 XUVs
C:0 T:5 28795 XUs and 28061 XVs -> 3198 XUVs
C:0 T:6 81505 XUs and 99152 XVs -> 3053 XUVs
C:0 T:7 625 XUs and 717 XVs -> 24 XUVs
8428 XUVs total
2315 collection wire objects
8428 potential space points
Neighbour search...
663604 tests to find 364598 neighbours
Iterating with no regularization...
Begin: 1.2561e+07
0 1.14588e+07
1 1.13508e+07
2 1.13366e+07
3 1.13318e+07
Now with regularization...
Begin: 1.07195e+07
0 1.07158e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29107 subRun: 1 event: 363872 at 26-Sep-2024 13:04:19 CEST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 63151 traces, 63151 summary
Retagger: tagging trace set: gauss with 47345 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 47345 traces tagged "gauss"
FrameSaver: q=978801 n=842426 tag=gauss
wclsFrameSaver: saving 63151 traces tagged "wiener"
FrameSaver: q=1.06613e+06 n=756172 tag=wiener
4897 hits in TPC 0
3502 hits in TPC 1
5718 hits in TPC 2
4005 hits in TPC 3
2719 hits in TPC 4
4196 hits in TPC 5
4976 hits in TPC 6
2981 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 332 XUs and 376 XVs -> 5 XUVs
C:0 T:2 29890 XUs and 32991 XVs -> 1559 XUVs
C:0 T:3 47 XUs and 47 XVs -> 3 XUVs
C:0 T:4 103 XUs and 161 XVs -> 11 XUVs
C:0 T:5 23202 XUs and 20570 XVs -> 1913 XUVs
C:0 T:6 24161 XUs and 31951 XVs -> 1468 XUVs
C:0 T:7 235 XUs and 142 XVs -> 9 XUVs
4968 XUVs total
1509 collection wire objects
4968 potential space points
Neighbour search...
391914 tests to find 193896 neighbours
Iterating with no regularization...
Begin: 8.47095e+06
0 7.09266e+06
1 7.03155e+06
2 7.01984e+06
3 7.01596e+06
Now with regularization...
Begin: 6.50024e+06
0 6.49755e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

26-Sep-2024 13:05:43 CEST  Closed output file "np04hd_raw_run029107_1515_dataflow0_datawriter_0_20240907T165146_reco_stage1_reco_stage2_20240926T110543_keepup.root"
26-Sep-2024 13:05:43 CEST  Closed input file "np04hd_raw_run029107_1515_dataflow0_datawriter_0_20240907T165146_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              70.1033       91.4987       130.025       90.2645       17.2638        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.00062078    0.00276328    0.00892198    0.00255313    0.00176598       30     
produce:fembfilter:PDHDFEMBFilter                      0.533095       0.64845      0.809053      0.640088      0.0932609       30     
produce:wclsdatahd:WireCellToolkit                      34.5394       41.0968       48.943        39.9783       4.52403        30     
produce:gaushit:GausHitFinder                          0.400898      0.691766       1.13835      0.661309      0.168893        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000243799   0.000416286   0.00078032    0.000385356   0.000124564      30     
produce:reco3d:SpacePointSolver                        0.204846       1.01969       2.93604      0.726712      0.750173        30     
produce:hitpdune:DisambigFromSpacePoints               0.231118      0.476381      0.848604      0.419888      0.174607        30     
produce:pandora:StandardPandora                         5.5686        11.563        22.7963       10.8177       4.49309        30     
produce:pandoraWriter:StandardPandora                  0.0913294     0.148285      0.277241      0.142483      0.0459116       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.624947       1.08659       2.50706      0.944389      0.472581        30     
produce:pandoraShower:LArPandoraShowerCreation         0.723932       1.26005       2.70965       1.10499      0.532182        30     
produce:pandoracalo:Calorimetry                        0.340905      0.552403       1.17476      0.496986       0.18544        30     
produce:pandoracalonosce:Calorimetry                   0.311501      0.493214       1.04498      0.446317       0.17398        30     
produce:pandorapid:Chi2ParticleID                     0.00112172     0.0017246     0.0038422    0.00147843    0.000662069      30     
produce:pandoraShowercalo:ShowerCalorimetry            0.629086       1.18308       2.56853       1.0632       0.485373        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.702052       1.12144       2.18635      0.982313      0.413276        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.088677      0.139388      0.240907      0.125396      0.0428701       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0318925     0.0466902     0.0838503     0.0431862     0.0145033       30     
produce:emtrkmichelid:EmTrackMichelId                   20.2227       28.5252       46.6138       27.7688       6.58766        30     
[art]:TriggerResults:TriggerResultInserter             1.581e-05    3.73888e-05   9.9237e-05    2.77825e-05   2.15428e-05      30     
end_path:out1:RootOutput                               6.282e-06    1.01184e-05   2.9546e-05     8.506e-06    5.14329e-06      30     
end_path:michelremoving:michelremoving                 0.0170574     0.0610736      0.23386      0.0300327     0.0585927       30     
end_path:michelremovinggnocchi:michelremoving          0.0150397     0.0584703     0.226029      0.0261733     0.0597717       30     
end_path:calibanagnocchi:CalibAnaTree                  0.232264      0.402468      0.763298      0.366663      0.134528        30     
end_path:out1:RootOutput(write)                        0.544915      0.790091       1.2186       0.754242      0.184312        30     
========================================================================================================================================

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

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