justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

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

Jobsub ID78679.158@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:23:56
SiteUK_Manchester
EntryUBoone_T2_UK_Manchester_ce02
Last heartbeat2024-09-26 14:15:32
From worker nodeHostnamewn2206301.tier2.hep.manchester.ac.uk
cpuinfoIntel(R) Xeon(R) Gold 5118 CPU @ 2.30GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit257400 (71 hours)
Inner Apptainer?True
Job statejobscript_error
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-09-26 12:09:39
Input fileshd-protodune:np04hd_raw_run029081_1007_dataflow0_datawriter_0_20240905T085312.hdf5
JobscriptExit code1
Real time0m (0s)
CPU time0m (0s = 0%)
Outputting started 
Output files
Finished2024-09-26 14:15:32
Saved logsjustin-logs:78679.158-justin-prod-sched02.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

253 XUs and 196 XVs -> 3 XUVs
8704 XUVs total
2317 collection wire objects
8704 potential space points
Neighbour search...
763336 tests to find 409348 neighbours
Iterating with no regularization...
Begin: 1.83288e+07
0 1.62432e+07
1 1.60933e+07
2 1.60721e+07
3 1.60639e+07
Now with regularization...
Begin: 1.4913e+07
0 1.49042e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 29th record. run: 29081 subRun: 1 event: 241928 at 26-Sep-2024 15:08:31 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 54043 traces, 54043 summary
Retagger: tagging trace set: gauss with 41083 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 41083 traces tagged "gauss"
FrameSaver: q=819610 n=751117 tag=gauss
wclsFrameSaver: saving 54043 traces tagged "wiener"
FrameSaver: q=877210 n=678454 tag=wiener
3950 hits in TPC 0
3120 hits in TPC 1
5297 hits in TPC 2
2550 hits in TPC 3
2197 hits in TPC 4
4200 hits in TPC 5
5145 hits in TPC 6
1385 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 2384 XUs and 1366 XVs -> 23 XUVs
C:0 T:2 22178 XUs and 30202 XVs -> 2897 XUVs
C:0 T:3 523 XUs and 878 XVs -> 11 XUVs
C:0 T:4 110 XUs and 168 XVs -> 3 XUVs
C:0 T:5 6135 XUs and 11015 XVs -> 351 XUVs
C:0 T:6 19647 XUs and 13152 XVs -> 744 XUVs
C:0 T:7 323 XUs and 368 XVs -> 5 XUVs
4034 XUVs total
1072 collection wire objects
4034 potential space points
Neighbour search...
434722 tests to find 199062 neighbours
Iterating with no regularization...
Begin: 4.22915e+06
0 3.98244e+06
1 3.96504e+06
2 3.96151e+06
Now with regularization...
Begin: 3.61475e+06
0 3.61338e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

Begin processing the 30th record. run: 29081 subRun: 1 event: 241936 at 26-Sep-2024 15:11:14 BST
RawFrameSource: got 10240 raw::RawDigit objects
	input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 85174 traces, 85174 summary
Retagger: tagging trace set: gauss with 61404 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 61404 traces tagged "gauss"
FrameSaver: q=1.43262e+06 n=1136461 tag=gauss
wclsFrameSaver: saving 85174 traces tagged "wiener"
FrameSaver: q=1.54213e+06 n=1035983 tag=wiener
3604 hits in TPC 0
3579 hits in TPC 1
6014 hits in TPC 2
3758 hits in TPC 3
5972 hits in TPC 4
9403 hits in TPC 5
6499 hits in TPC 6
5328 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 908 XUs and 444 XVs -> 5 XUVs
C:0 T:2 23704 XUs and 24311 XVs -> 818 XUVs
C:0 T:3 70 XUs and 91 XVs -> 4 XUVs
C:0 T:4 1223 XUs and 1417 XVs -> 78 XUVs
C:0 T:5 33923 XUs and 43161 XVs -> 1632 XUVs
C:0 T:6 30346 XUs and 28246 XVs -> 1124 XUVs
C:0 T:7 717 XUs and 861 XVs -> 22 XUVs
3683 XUVs total
1673 collection wire objects
3683 potential space points
Neighbour search...
91039 tests to find 56314 neighbours
Iterating with no regularization...
Begin: 1.34339e+07
0 1.25053e+07
1 1.24502e+07
2 1.24437e+07
Now with regularization...
Begin: 1.16914e+07
0 1.16886e+07
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

no of hits closeby  1   event 241936 TrkackID 13 startx, y, z 215.99 603.63 313.373  wireno, peakt tpcno 55 4680.37 5 dist 0min T, max_T2142.69 4887.93
no of hits closeby  1   event 241936 TrkackID 13 startx, y, z 215.99 603.63 313.373  wireno, peakt tpcno 55 4680.37 5 dist 0min T, max_T2142.69 4887.93
26-Sep-2024 15:14:50 BST  Closed output file "np04hd_raw_run029081_1007_dataflow0_datawriter_0_20240905T085312_reco_stage1_reco_stage2_20240926T141450_keepup.root"
26-Sep-2024 15:14:50 BST  Closed input file "np04hd_raw_run029081_1007_dataflow0_datawriter_0_20240905T085312_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              113.154       182.223       293.006       163.73        47.7433        30     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.00147788    0.00388231     0.0174333    0.00355913    0.00274435       30     
produce:fembfilter:PDHDFEMBFilter                       0.74236       1.14003       1.83943       1.11295      0.246521        30     
produce:wclsdatahd:WireCellToolkit                      53.8399       70.7487       83.9107       71.6426       6.34119        30     
produce:gaushit:GausHitFinder                          0.515263       1.22501       2.03136       1.22098      0.373458        30     
produce:nhitsfilter:NumberOfHitsFilter                0.000357992   0.000623325   0.00107802    0.000568646   0.000181654      30     
produce:reco3d:SpacePointSolver                        0.143802       1.97017       9.36149       1.46323       1.66924        30     
produce:hitpdune:DisambigFromSpacePoints               0.198769       1.16644       3.34186      0.985127      0.736671        30     
produce:pandora:StandardPandora                         7.90049       24.4457       92.7335       17.4373       18.0797        30     
produce:pandoraWriter:StandardPandora                  0.105739       0.25677      0.438075       0.23649      0.0790241       30     
produce:pandoraTrack:LArPandoraTrackCreation           0.597136       3.88367       8.19128       3.75808       1.84939        30     
produce:pandoraShower:LArPandoraShowerCreation         0.518535       5.03537       12.4724       4.56147       3.14334        30     
produce:pandoracalo:Calorimetry                        0.283879       1.63791       3.78556       1.62615      0.824829        30     
produce:pandoracalonosce:Calorimetry                   0.256072       1.55213       3.72246       1.42541       0.82686        30     
produce:pandorapid:Chi2ParticleID                      0.0012396    0.00328631    0.00651846    0.00331262    0.00115603       30     
produce:pandoraShowercalo:ShowerCalorimetry            0.438097       3.95217       11.6342       3.65448       2.68733        30     
produce:pandoraShowercalonosce:ShowerCalorimetry       0.426301       3.8039        10.1647       3.54532       2.57106        30     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.0780625     0.236581      0.500946      0.227794      0.0885557       30     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.028967      0.0893964     0.188569      0.0849496     0.031819        30     
produce:emtrkmichelid:EmTrackMichelId                   32.1564       57.8258       90.3194       54.0603       15.9653        30     
[art]:TriggerResults:TriggerResultInserter            5.3503e-05    7.84568e-05   0.000184245   7.64205e-05   2.25506e-05      30     
end_path:out1:RootOutput                              1.0749e-05    2.06967e-05   5.0123e-05    1.95595e-05   6.67668e-06      30     
end_path:michelremoving:michelremoving                 0.0331296     0.159901      0.699519      0.0807367     0.165956        30     
end_path:michelremovinggnocchi:michelremoving          0.0334327     0.155705      0.694247      0.0749893     0.163854        30     
end_path:calibanagnocchi:CalibAnaTree                   0.33592       1.29641       3.13907       1.22181      0.672265        30     
end_path:out1:RootOutput(write)                        0.717803       1.40995       2.61052       1.41979      0.444485        30     
========================================================================================================================================

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

  Peak virtual memory usage (VmPeak)  : 4937.52 MB
  Peak resident set size usage (VmHWM): 2609.78 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_1007_dataflow0_datawriter_0_20240905T085312_reco_stage1_reco_stage2_20240926T141450_keepup.root
\tHists: np04hd_raw_run029081_1007_dataflow0_datawriter_0_20240905T085312_reco_stage1_reco_stage2_20240926T141450_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 08:01:04 UTC       justIN version: 01.01.09