Jobsub ID 263276.138@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 263276.138@justin-prod-sched01.dune.hep.ac.uk |
Workflow ID | 3447 |
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 09:54:33 |
Site | FR_CCIN2P3 |
Entry | DUNE_FR_CCIN2P3_cccondorce01 |
Last heartbeat | 2024-09-26 11:30:18 |
From worker node | Hostname | ccwcondor0576 |
cpuinfo | AMD EPYC 7453 28-Core Processor |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 4193255424 (3999 MiB) |
Wall seconds limit | 106200 (29 hours) |
Inner Apptainer? | True |
Job state | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2024-09-26 09:55:31 |
Input files | hd-protodune:np04hd_raw_run029092_0569_dataflow5_datawriter_0_20240906T020943.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 11:30:18 |
Saved logs | justin-logs:263276.138-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
our search...
459073 tests to find 213914 neighbours
Iterating with no regularization...
Begin: 5.36982e+06
0 4.85178e+06
1 4.81301e+06
2 4.80656e+06
3 4.80443e+06
Now with regularization...
Begin: 4.48136e+06
0 4.47995e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 136781 TrkackID 27 startx, y, z 50.5705 94.0035 453.215 wireno, peakt tpcno 401 5575.12 5 dist 0min T, max_T5123.82 5777.32
no of hits closeby 0 event 136781 TrkackID 27 startx, y, z 50.5705 94.0035 453.215 wireno, peakt tpcno 401 5575.12 5 dist 0min T, max_T5123.82 5777.32
Begin processing the 29th record. run: 29092 subRun: 1 event: 136789 at 26-Sep-2024 13:07:50 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 115879 traces, 115879 summary
Retagger: tagging trace set: gauss with 85522 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 85522 traces tagged "gauss"
FrameSaver: q=1.8208e+06 n=1546424 tag=gauss
wclsFrameSaver: saving 115879 traces tagged "wiener"
FrameSaver: q=1.96763e+06 n=1387142 tag=wiener
4740 hits in TPC 0
5410 hits in TPC 1
8257 hits in TPC 2
3764 hits in TPC 3
6533 hits in TPC 4
10653 hits in TPC 5
15387 hits in TPC 6
5058 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 25 XUs and 14 XVs -> 0 XUVs
C:0 T:1 1592 XUs and 1675 XVs -> 59 XUVs
C:0 T:2 85007 XUs and 81730 XVs -> 3289 XUVs
C:0 T:3 77 XUs and 62 XVs -> 1 XUVs
C:0 T:4 252 XUs and 140 XVs -> 12 XUVs
C:0 T:5 65536 XUs and 43908 XVs -> 1103 XUVs
C:0 T:6 120286 XUs and 150571 XVs -> 6215 XUVs
C:0 T:7 55 XUs and 86 XVs -> 2 XUVs
10681 XUVs total
3069 collection wire objects
10681 potential space points
Neighbour search...
738693 tests to find 387148 neighbours
Iterating with no regularization...
Begin: 1.46804e+07
0 1.30097e+07
1 1.28665e+07
2 1.28444e+07
3 1.2838e+07
Now with regularization...
Begin: 1.20954e+07
0 1.20917e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 1 event 136789 TrkackID 14 startx, y, z 17.2879 590.796 350.083 wireno, peakt tpcno 450 3460.84 5 dist 0min T, max_T3407.92 4958.57
no of hits closeby 1 event 136789 TrkackID 14 startx, y, z 17.2879 590.796 350.083 wireno, peakt tpcno 450 3460.84 5 dist 0min T, max_T3407.92 4958.57
Begin processing the 30th record. run: 29092 subRun: 1 event: 136797 at 26-Sep-2024 13:10:26 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 84613 traces, 84613 summary
Retagger: tagging trace set: gauss with 61929 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 61929 traces tagged "gauss"
FrameSaver: q=1.46453e+06 n=1135691 tag=gauss
wclsFrameSaver: saving 84613 traces tagged "wiener"
FrameSaver: q=1.5927e+06 n=1037027 tag=wiener
4959 hits in TPC 0
3466 hits in TPC 1
6365 hits in TPC 2
2819 hits in TPC 3
5897 hits in TPC 4
10740 hits in TPC 5
6695 hits in TPC 6
3620 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 9 XUs and 13 XVs -> 0 XUVs
C:0 T:1 1038 XUs and 355 XVs -> 32 XUVs
C:0 T:2 28776 XUs and 49287 XVs -> 1673 XUVs
C:0 T:3 22 XUs and 12 XVs -> 0 XUVs
C:0 T:4 175 XUs and 143 XVs -> 7 XUVs
C:0 T:5 79897 XUs and 66281 XVs -> 2132 XUVs
C:0 T:6 24091 XUs and 49366 XVs -> 2159 XUVs
C:0 T:7 84 XUs and 109 XVs -> 8 XUVs
6011 XUVs total
2143 collection wire objects
6011 potential space points
Neighbour search...
367147 tests to find 214522 neighbours
Iterating with no regularization...
Begin: 1.2823e+07
0 1.14811e+07
1 1.13716e+07
2 1.13543e+07
3 1.1349e+07
Now with regularization...
Begin: 1.07098e+07
0 1.07066e+07
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 13:12:20 CEST Closed output file "np04hd_raw_run029092_0569_dataflow5_datawriter_0_20240906T020943_reco_stage1_reco_stage2_20240926T111220_keepup.root"
26-Sep-2024 13:12:20 CEST Closed input file "np04hd_raw_run029092_0569_dataflow5_datawriter_0_20240906T020943_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 53.7477 114.493 170.025 109.184 27.9799 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.00050259 0.00338412 0.00634928 0.00337633 0.00143811 30
produce:fembfilter:PDHDFEMBFilter 0.528968 0.721003 0.834295 0.742577 0.0709694 30
produce:wclsdatahd:WireCellToolkit 38.9837 44.1157 50.2199 43.9755 2.74141 30
produce:gaushit:GausHitFinder 0.38962 0.838606 2.06649 0.815455 0.306692 30
produce:nhitsfilter:NumberOfHitsFilter 0.000244748 0.000379837 0.000711341 0.000361526 9.67926e-05 30
produce:reco3d:SpacePointSolver 0.268918 1.16405 3.67622 1.05187 0.807383 29
produce:hitpdune:DisambigFromSpacePoints 0.160523 0.704288 1.42852 0.66692 0.326843 29
produce:pandora:StandardPandora 5.69448 16.8938 38.9052 14.9568 8.25474 29
produce:pandoraWriter:StandardPandora 0.0858612 0.193627 0.291981 0.17659 0.0542601 29
produce:pandoraTrack:LArPandoraTrackCreation 0.521746 2.45044 7.47671 1.98241 1.4341 29
produce:pandoraShower:LArPandoraShowerCreation 0.633312 3.26127 7.11962 2.9681 1.90362 29
produce:pandoracalo:Calorimetry 0.288713 1.15738 2.48073 1.00194 0.571047 29
produce:pandoracalonosce:Calorimetry 0.275511 1.1149 2.31835 0.944638 0.546746 29
produce:pandorapid:Chi2ParticleID 0.00149784 0.00246101 0.00534907 0.00236483 0.000688721 29
produce:pandoraShowercalo:ShowerCalorimetry 0.489816 2.78645 6.22435 2.42569 1.62498 29
produce:pandoraShowercalonosce:ShowerCalorimetry 0.426048 2.74624 7.20048 2.15464 1.75106 29
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0866602 0.170774 0.243706 0.183327 0.0412031 29
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0276685 0.0614264 0.0907822 0.0618434 0.0148763 29
produce:emtrkmichelid:EmTrackMichelId 14.766 36.2936 55.0007 36.2792 9.47236 29
[art]:TriggerResults:TriggerResultInserter 3.5175e-05 6.94765e-05 0.0001551 6.8248e-05 2.07186e-05 30
end_path:out1:RootOutput 1.5119e-05 2.148e-05 4.6236e-05 1.91555e-05 7.01533e-06 30
end_path:michelremoving:michelremoving 7.3858e-05 0.134513 0.50469 0.062744 0.125927 30
end_path:michelremovinggnocchi:michelremoving 4.4193e-05 0.130808 0.502538 0.0546675 0.1286 30
end_path:calibanagnocchi:CalibAnaTree 5.0134e-05 0.7491 1.47003 0.723378 0.38045 30
end_path:out1:RootOutput(write) 0.437959 0.870363 1.29823 0.852709 0.21127 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4939.21 MB
Peak resident set size usage (VmHWM): 2365.42 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029092_0569_dataflow5_datawriter_0_20240906T020943_reco_stage1_reco_stage2_20240926T111220_keepup.root
\tHists: np04hd_raw_run029092_0569_dataflow5_datawriter_0_20240906T020943_reco_stage1_reco_stage2_20240926T111220_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