Jobsub ID 263681.185@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 263681.185@justin-prod-sched01.dune.hep.ac.uk |
| Workflow ID | 3451 |
| Stage ID | 1 |
| User name | calcuttj@fnal.gov |
| HTCondor Group | group_dune.prod_mcsim |
| Requested | Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) |
| Wall seconds limit | 18000 (5 hours) |
| Submitted time | 2024-09-26 13:07:22 |
| Site | ES_PIC |
| Entry | DUNE_T1_ES_PIC_ce14-multicore |
| Last heartbeat | 2024-09-26 14:36:55 |
| From worker node | Hostname | tds211.pic.es |
| cpuinfo | Intel(R) Xeon(R) CPU E5-2640 v3 @ 2.60GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4193255424 (3999 MiB) |
| Wall seconds limit | 216000 (60 hours) |
| Inner Apptainer? | True |
| Job state | jobscript_error |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-09-26 13:08:09 |
| Input files | hd-protodune:np04hd_raw_run029107_2140_dataflow0_datawriter_0_20240908T021857.hdf5
|
| Jobscript | Exit code | 1 |
| Real time | 0m (0s) |
| CPU time | 0m (0s = 0%) |
| Outputting started | |
| Output files | |
| Finished | 2024-09-26 14:36:55 |
| Saved logs | justin-logs:263681.185-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
08.421 wireno, peakt tpcno 122 2.25263 5 dist 0min T, max_T2.25263 4080.5
no of hits closeby 0 event 513848 TrkackID 4 startx, y, z 51.0883 589.9 308.421 wireno, peakt tpcno 122 2.25263 5 dist 0min T, max_T2.25263 4080.5
Begin processing the 29th record. run: 29107 subRun: 1 event: 513856 at 26-Sep-2024 16:33:27 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 54153 traces, 54153 summary
Retagger: tagging trace set: gauss with 38306 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 38306 traces tagged "gauss"
FrameSaver: q=736583 n=656983 tag=gauss
wclsFrameSaver: saving 54153 traces tagged "wiener"
FrameSaver: q=793980 n=580381 tag=wiener
1640 hits in TPC 0
2532 hits in TPC 1
5160 hits in TPC 2
2529 hits in TPC 3
3041 hits in TPC 4
4500 hits in TPC 5
4099 hits in TPC 6
2157 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 4 XUs and 3 XVs -> 0 XUVs
C:0 T:2 12466 XUs and 18453 XVs -> 686 XUVs
C:0 T:3 72 XUs and 103 XVs -> 0 XUVs
C:0 T:4 47 XUs and 53 XVs -> 7 XUVs
C:0 T:5 16198 XUs and 15528 XVs -> 357 XUVs
C:0 T:6 9841 XUs and 14053 XVs -> 170 XUVs
C:0 T:7 6 XUs and 16 XVs -> 0 XUVs
1220 XUVs total
619 collection wire objects
1220 potential space points
Neighbour search...
47598 tests to find 31740 neighbours
Iterating with no regularization...
Begin: 2.32513e+06
0 2.07416e+06
1 2.05785e+06
2 2.05644e+06
Now with regularization...
Begin: 1.93926e+06
0 1.93881e+06
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--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 1 event 513856 TrkackID 1 startx, y, z -73.6493 530.01 7.23205 wireno, peakt tpcno 474 765.223 6 dist 0min T, max_T745.817 2008.29
no of hits closeby 0 event 513856 TrkackID 2 startx, y, z -93.9662 341.151 442.501 wireno, peakt tpcno 11 3464.45 2 dist 0min T, max_T2375.53 3586.31
no of hits closeby 1 event 513856 TrkackID 1 startx, y, z -73.6493 530.01 7.23205 wireno, peakt tpcno 474 765.223 6 dist 0min T, max_T745.817 2008.29
no of hits closeby 0 event 513856 TrkackID 2 startx, y, z -93.9662 341.151 442.501 wireno, peakt tpcno 11 3464.45 2 dist 0min T, max_T2375.53 3586.31
Begin processing the 30th record. run: 29107 subRun: 1 event: 513864 at 26-Sep-2024 16:35:10 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 43757 traces, 43757 summary
Retagger: tagging trace set: gauss with 32334 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 32334 traces tagged "gauss"
FrameSaver: q=633964 n=542446 tag=gauss
wclsFrameSaver: saving 43757 traces tagged "wiener"
FrameSaver: q=691921 n=481741 tag=wiener
3540 hits in TPC 0
2876 hits in TPC 1
3989 hits in TPC 2
2520 hits in TPC 3
2065 hits in TPC 4
4522 hits in TPC 5
1369 hits in TPC 6
936 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 274 XUs and 421 XVs -> 11 XUVs
C:0 T:2 56193 XUs and 17871 XVs -> 679 XUVs
C:0 T:3 32 XUs and 53 XVs -> 6 XUVs
C:0 T:4 16 XUs and 13 XVs -> 0 XUVs
C:0 T:5 9111 XUs and 20311 XVs -> 2407 XUVs
C:0 T:6 15137 XUs and 1754 XVs -> 96 XUVs
C:0 T:7 0 XUs and 4 XVs -> 0 XUVs
3199 XUVs total
669 collection wire objects
3199 potential space points
Neighbour search...
160691 tests to find 97904 neighbours
Iterating with no regularization...
Begin: 1.33854e+07
0 1.07859e+07
1 1.04911e+07
2 1.04803e+07
3 1.04772e+07
Now with regularization...
Begin: 1.01907e+07
0 1.0189e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
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--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 16:36:33 CEST Closed output file "np04hd_raw_run029107_2140_dataflow0_datawriter_0_20240908T021857_reco_stage1_reco_stage2_20240926T143633_keepup.root"
26-Sep-2024 16:36:33 CEST Closed input file "np04hd_raw_run029107_2140_dataflow0_datawriter_0_20240908T021857_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 63.1013 96.9166 145.066 94.7036 18.1484 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000520718 0.00222011 0.0036234 0.00246477 0.000808359 30
produce:fembfilter:PDHDFEMBFilter 0.576589 0.63446 0.704078 0.631303 0.0374488 30
produce:wclsdatahd:WireCellToolkit 40.5622 47.6671 60.6075 47.3619 5.30706 30
produce:gaushit:GausHitFinder 0.275064 0.729692 1.0351 0.776264 0.195233 30
produce:nhitsfilter:NumberOfHitsFilter 0.000142334 0.000370875 0.000633759 0.000361828 0.000116077 30
produce:reco3d:SpacePointSolver 0.0597867 0.794484 2.55995 0.60444 0.565882 30
produce:hitpdune:DisambigFromSpacePoints 0.0707175 0.568265 1.38516 0.565622 0.301498 30
produce:pandora:StandardPandora 4.71034 13.7851 31.95 12.2663 6.35957 30
produce:pandoraWriter:StandardPandora 0.0745974 0.144729 0.24123 0.142079 0.0382539 30
produce:pandoraTrack:LArPandoraTrackCreation 0.452609 1.28461 2.49258 1.21102 0.514632 30
produce:pandoraShower:LArPandoraShowerCreation 0.393125 1.52086 3.68091 1.38236 0.799673 30
produce:pandoracalo:Calorimetry 0.225325 0.644754 1.20265 0.637841 0.241702 30
produce:pandoracalonosce:Calorimetry 0.202051 0.591 1.14766 0.576347 0.221131 30
produce:pandorapid:Chi2ParticleID 0.00121838 0.00183132 0.00333959 0.00167017 0.000498799 30
produce:pandoraShowercalo:ShowerCalorimetry 0.349111 1.39986 3.32188 1.34024 0.704897 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.347131 1.3634 3.20673 1.34334 0.671581 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0692548 0.129969 0.185246 0.129876 0.0334192 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0249883 0.0463899 0.0670004 0.0449886 0.0116652 30
produce:emtrkmichelid:EmTrackMichelId 13.7735 24.0431 38.0683 24.7313 5.7188 30
[art]:TriggerResults:TriggerResultInserter 2.0154e-05 3.24263e-05 8.2883e-05 2.99045e-05 1.24491e-05 30
end_path:out1:RootOutput 4.347e-06 8.39133e-06 3.2113e-05 7.438e-06 4.62101e-06 30
end_path:michelremoving:michelremoving 0.0174661 0.124146 0.397491 0.0809659 0.107989 30
end_path:michelremovinggnocchi:michelremoving 0.0151999 0.121743 0.400381 0.0795102 0.108846 30
end_path:calibanagnocchi:CalibAnaTree 0.171368 0.507229 0.974285 0.50635 0.187308 30
end_path:out1:RootOutput(write) 0.364775 0.725175 1.11044 0.744698 0.188795 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4986.61 MB
Peak resident set size usage (VmHWM): 2596.74 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_2140_dataflow0_datawriter_0_20240908T021857_reco_stage1_reco_stage2_20240926T143633_keepup.root
\tHists: np04hd_raw_run029107_2140_dataflow0_datawriter_0_20240908T021857_reco_stage1_reco_stage2_20240926T143633_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
