justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78692.145@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 11:28:51
SiteUK_Durham
EntryDUNE_UK_SGridDurham_ce4
Last heartbeat2024-09-26 14:14:08
From worker nodeHostnamen173.dur.scotgrid.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 5220 CPU @ 2.20GHz
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 12:18:11
Input fileshd-protodune:np04hd_raw_run029081_0689_dataflow3_datawriter_0_20240905T035831.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 14:14:08
Saved logsjustin-logs:78692.145-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

ization...
Begin: 1.61903e+07
0 1.61857e+07
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 29th record. run: 29081 subRun: 1 event: 165587 at 26-Sep-2024 15:10:32 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 72587 traces, 72587 summary
Retagger: tagging trace set: gauss with 56643 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 56643 traces tagged "gauss"
FrameSaver: q=1.24756e+06 n=1115567 tag=gauss
wclsFrameSaver: saving 72587 traces tagged "wiener"
FrameSaver: q=1.32161e+06 n=1021478 tag=wiener
5521 hits in TPC 0
2845 hits in TPC 1
9477 hits in TPC 2
4311 hits in TPC 3
4877 hits in TPC 4
6085 hits in TPC 5
5531 hits in TPC 6
2147 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 68 XUs and 34 XVs -> 1 XUVs
C:0 T:2 37510 XUs and 36975 XVs -> 1267 XUVs
C:0 T:3 364 XUs and 353 XVs -> 4 XUVs
C:0 T:4 155 XUs and 123 XVs -> 3 XUVs
C:0 T:5 39911 XUs and 30052 XVs -> 1370 XUVs
C:0 T:6 19197 XUs and 15845 XVs -> 373 XUVs
C:0 T:7 841 XUs and 607 XVs -> 23 XUVs
3041 XUVs total
1659 collection wire objects
3041 potential space points
Neighbour search...
85023 tests to find 45674 neighbours
Iterating with no regularization...
Begin: 1.21832e+07
0 1.17823e+07
1 1.17553e+07
2 1.17492e+07
Now with regularization...
Begin: 1.11601e+07
0 1.11574e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 165587 TrkackID 21 startx, y, z 76.1141 593.386 308.523  wireno, peakt tpcno 176 5303.85 5 dist 0min T, max_T4456.69 5432.93
no of hits closeby  0   event 165587 TrkackID 21 startx, y, z 76.1141 593.386 308.523  wireno, peakt tpcno 176 5303.85 5 dist 0min T, max_T4456.69 5432.93
Begin processing the 30th record. run: 29081 subRun: 1 event: 165595 at 26-Sep-2024 15:12:12 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 53886 traces, 53886 summary
Retagger: tagging trace set: gauss with 42441 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 42441 traces tagged "gauss"
FrameSaver: q=947973 n=843161 tag=gauss
wclsFrameSaver: saving 53886 traces tagged "wiener"
FrameSaver: q=1.00178e+06 n=775301 tag=wiener
2974 hits in TPC 0
3417 hits in TPC 1
5244 hits in TPC 2
4150 hits in TPC 3
3720 hits in TPC 4
4725 hits in TPC 5
3576 hits in TPC 6
2612 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 3730 XUs and 3826 XVs -> 163 XUVs
C:0 T:2 11661 XUs and 16544 XVs -> 553 XUVs
C:0 T:3 944 XUs and 933 XVs -> 32 XUVs
C:0 T:4 15 XUs and 15 XVs -> 1 XUVs
C:0 T:5 10355 XUs and 10547 XVs -> 470 XUVs
C:0 T:6 7748 XUs and 7379 XVs -> 241 XUVs
C:0 T:7 104 XUs and 142 XVs -> 3 XUVs
1463 XUVs total
1064 collection wire objects
1463 potential space points
Neighbour search...
25575 tests to find 14558 neighbours
Iterating with no regularization...
Begin: 8.98267e+06
0 8.69984e+06
1 8.69338e+06
Now with regularization...
Begin: 8.20459e+06
0 8.20391e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  0   event 165595 TrkackID 8 startx, y, z -10.7805 525.066 12.5107  wireno, peakt tpcno 162 3.65419 2 dist 0min T, max_T3.65419 2514.54
no of hits closeby  0   event 165595 TrkackID 8 startx, y, z -10.7805 525.066 12.5107  wireno, peakt tpcno 162 3.65419 2 dist 0min T, max_T3.65419 2514.54
26-Sep-2024 15:13:32 BST  Closed output file "np04hd_raw_run029081_0689_dataflow3_datawriter_0_20240905T035831_reco_stage1_reco_stage2_20240926T141332_keepup.root"
26-Sep-2024 15:13:32 BST  Closed input file "np04hd_raw_run029081_0689_dataflow3_datawriter_0_20240905T035831_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              77.3591       115.884       166.78        114.028       26.7132        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000359919   0.00139694    0.00396997    0.000921818   0.00109413       30     
produce:fembfilter:PDHDFEMBFilter                      0.700501       0.99763       1.39268       1.07004      0.231662        30     
produce:wclsdatahd:WireCellToolkit                      43.4497       58.228        73.8566       63.5619       10.8605        30     
produce:gaushit:GausHitFinder                          0.601128       1.05873       1.77195       1.02752      0.317263        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000300019   0.000469605   0.00153907    0.000414231   0.000223714      30     
produce:reco3d:SpacePointSolver                        0.250062       1.20889       3.91901      0.893607      0.981551        30     
produce:hitpdune:DisambigFromSpacePoints               0.305288      0.882015       1.68134      0.826299      0.419077        30     
produce:pandora:StandardPandora                         8.38673       16.7029        31.9          14.94        6.69128        30     
produce:pandoraWriter:StandardPandora                  0.116218       0.20807      0.320916      0.198054      0.0638388       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.934935       2.0399        3.99993       1.72949      0.903091        30     
produce:pandoraShower:LArPandoraShowerCreation          1.01372       2.39496       5.15291       2.15205       1.11837        30     
produce:pandoracalo:Calorimetry                        0.454452      0.962051       2.00074      0.831386      0.422093        30     
produce:pandoracalonosce:Calorimetry                   0.411329      0.892306       1.93907      0.772279      0.409629        30     
produce:pandorapid:Chi2ParticleID                     0.00150183    0.00256454    0.00497598    0.00232575    0.000961683      30     
produce:pandoraShowercalo:ShowerCalorimetry             0.90145       2.15507       4.27266       1.9414       0.969594        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.892896       2.13605       4.21327       1.84743      0.964419        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0926398     0.203876      0.393916      0.180551      0.0775735       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0373735     0.0770313     0.136366      0.0703806     0.0289851       30     
produce:emtrkmichelid:EmTrackMichelId                   14.5456       23.356        35.6786       22.5914       5.86854        30     
[art]:TriggerResults:TriggerResultInserter             2.769e-05    4.21555e-05    9.268e-05    3.49565e-05   1.55875e-05      30     
end_path:out1:RootOutput                               6.775e-06    9.9133e-06    2.6717e-05    8.2445e-06    4.03143e-06      30     
end_path:michelremoving:michelremoving                 0.0249488     0.130525      0.601261      0.0556152     0.161453        30     
end_path:michelremovinggnocchi:michelremoving          0.022226      0.128632      0.608191      0.0506863     0.169067        30     
end_path:calibanagnocchi:CalibAnaTree                  0.323235      0.776355       1.45929      0.700312      0.325906        30     
end_path:out1:RootOutput(write)                         0.63274       1.16203       1.9773        1.09272       0.37827        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 5882.64 MB
  Peak resident set size usage (VmHWM): 2995.71 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_0689_dataflow3_datawriter_0_20240905T035831_reco_stage1_reco_stage2_20240926T141332_keepup.root
\tHists: np04hd_raw_run029081_0689_dataflow3_datawriter_0_20240905T035831_reco_stage1_reco_stage2_20240926T141332_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 07:28:54 UTC       justIN version: 01.01.09