Jobsub ID 78430.172@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 78430.172@justin-prod-sched02.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:33:14 |
Site | FR_CCIN2P3 |
Entry | DUNE_FR_CCIN2P3_cccondorce02 |
Last heartbeat | 2024-09-26 11:01:05 |
From worker node | Hostname | ccwcondor0788 |
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:49:13 |
Input files | hd-protodune:np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 11:01:05 |
Saved logs | justin-logs:78430.172-justin-prod-sched02.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
eamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29081 subRun: 1 event: 133429 at 26-Sep-2024 12:49:46 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 48525 traces, 48525 summary
Retagger: tagging trace set: gauss with 36997 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 36997 traces tagged "gauss"
FrameSaver: q=783005 n=742419 tag=gauss
wclsFrameSaver: saving 48525 traces tagged "wiener"
FrameSaver: q=837116 n=680697 tag=wiener
4173 hits in TPC 0
3104 hits in TPC 1
4523 hits in TPC 2
2099 hits in TPC 3
3941 hits in TPC 4
6001 hits in TPC 5
2394 hits in TPC 6
1580 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 167 XUs and 120 XVs -> 5 XUVs
C:0 T:2 5514 XUs and 4278 XVs -> 276 XUVs
C:0 T:3 140 XUs and 101 XVs -> 7 XUVs
C:0 T:4 106 XUs and 225 XVs -> 9 XUVs
C:0 T:5 15146 XUs and 17562 XVs -> 898 XUVs
C:0 T:6 4171 XUs and 7804 XVs -> 204 XUVs
C:0 T:7 21 XUs and 35 XVs -> 0 XUVs
1399 XUVs total
845 collection wire objects
1399 potential space points
Neighbour search...
19443 tests to find 10886 neighbours
Iterating with no regularization...
Begin: 3.08188e+06
0 2.90807e+06
1 2.89568e+06
2 2.89523e+06
Now with regularization...
Begin: 2.55903e+06
0 2.55882e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 3 event 133429 TrkackID 0 startx, y, z 194.001 603.609 136.454 wireno, peakt tpcno 78 66.4188 5 dist 3.78333min T, max_T16.1112 3516
no of hits closeby 0 event 133429 TrkackID 6 startx, y, z 50.4289 590.484 318.169 wireno, peakt tpcno 457 4320.46 5 dist 0min T, max_T4317 5406.53
no of hits closeby 3 event 133429 TrkackID 0 startx, y, z 194.001 603.609 136.454 wireno, peakt tpcno 78 66.4188 5 dist 3.78333min T, max_T16.1112 3516
no of hits closeby 0 event 133429 TrkackID 6 startx, y, z 50.4289 590.484 318.169 wireno, peakt tpcno 457 4320.46 5 dist 0min T, max_T4317 5406.53
Begin processing the 30th record. run: 29081 subRun: 1 event: 133437 at 26-Sep-2024 12:50:53 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 52819 traces, 52819 summary
Retagger: tagging trace set: gauss with 38880 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 38880 traces tagged "gauss"
FrameSaver: q=832023 n=753216 tag=gauss
wclsFrameSaver: saving 52819 traces tagged "wiener"
FrameSaver: q=891696 n=683918 tag=wiener
3387 hits in TPC 0
3231 hits in TPC 1
6350 hits in TPC 2
2833 hits in TPC 3
3156 hits in TPC 4
3962 hits in TPC 5
3663 hits in TPC 6
2380 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 1155 XUs and 3066 XVs -> 3 XUVs
C:0 T:2 18046 XUs and 25541 XVs -> 403 XUVs
C:0 T:3 857 XUs and 697 XVs -> 12 XUVs
C:0 T:4 130 XUs and 195 XVs -> 12 XUVs
C:0 T:5 24271 XUs and 25294 XVs -> 1046 XUVs
C:0 T:6 6780 XUs and 10926 XVs -> 1372 XUVs
C:0 T:7 107 XUs and 144 XVs -> 4 XUVs
2852 XUVs total
1121 collection wire objects
2852 potential space points
Neighbour search...
133130 tests to find 84310 neighbours
Iterating with no regularization...
Begin: 4.49125e+06
0 4.11913e+06
1 4.0907e+06
2 4.08623e+06
3 4.08494e+06
Now with regularization...
Begin: 3.78183e+06
0 3.78098e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 0 event 133437 TrkackID 10 startx, y, z 62.1551 596.625 90.8771 wireno, peakt tpcno 194 2042 2 dist 202.646min T, max_T162.55 2066.09
no of hits closeby 0 event 133437 TrkackID 10 startx, y, z 62.1551 596.625 90.8771 wireno, peakt tpcno 194 2042 2 dist 202.646min T, max_T162.55 2066.09
26-Sep-2024 12:52:03 CEST Closed output file "np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236_reco_stage1_reco_stage2_20240926T105203_keepup.root"
26-Sep-2024 12:52:03 CEST Closed input file "np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 64.5107 93.9057 136.412 92.0163 17.8792 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000544949 0.00306148 0.00464942 0.00318592 0.00107213 30
produce:fembfilter:PDHDFEMBFilter 0.483081 0.599046 0.764548 0.564619 0.0840248 30
produce:wclsdatahd:WireCellToolkit 33.134 37.8737 42.3574 38.1187 2.51129 30
produce:gaushit:GausHitFinder 0.406668 0.620674 0.974979 0.61602 0.138144 30
produce:nhitsfilter:NumberOfHitsFilter 0.000229178 0.000331364 0.000508049 0.000333353 5.93862e-05 30
produce:reco3d:SpacePointSolver 0.159474 1.21865 5.60356 0.992547 1.05309 30
produce:hitpdune:DisambigFromSpacePoints 0.164728 0.460882 1.12243 0.387941 0.25403 30
produce:pandora:StandardPandora 4.89523 12.2752 25.3234 10.2804 5.60345 30
produce:pandoraWriter:StandardPandora 0.0892561 0.154927 0.246719 0.139944 0.044733 30
produce:pandoraTrack:LArPandoraTrackCreation 0.737095 1.7713 3.57624 1.64083 0.66792 30
produce:pandoraShower:LArPandoraShowerCreation 0.830492 2.20289 6.20598 1.75156 1.26646 30
produce:pandoracalo:Calorimetry 0.398921 0.868064 1.99231 0.755356 0.362906 30
produce:pandoracalonosce:Calorimetry 0.332697 0.771459 1.45731 0.736404 0.291798 30
produce:pandorapid:Chi2ParticleID 0.00129199 0.00223797 0.00727884 0.00192825 0.00128879 30
produce:pandoraShowercalo:ShowerCalorimetry 0.701788 1.87118 4.48242 1.58214 0.922542 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.592594 1.69124 3.98898 1.42933 0.862809 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0683798 0.119381 0.200534 0.111498 0.036003 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0245444 0.0430416 0.0687667 0.0410388 0.0124356 30
produce:emtrkmichelid:EmTrackMichelId 17.1928 29.666 43.7611 29.0521 6.65657 30
[art]:TriggerResults:TriggerResultInserter 3.9965e-05 6.86177e-05 0.000148818 6.5773e-05 2.42296e-05 30
end_path:out1:RootOutput 1.3375e-05 1.93515e-05 3.1418e-05 1.9341e-05 4.3323e-06 30
end_path:michelremoving:michelremoving 0.0200277 0.0943213 0.416082 0.0578404 0.0848115 30
end_path:michelremovinggnocchi:michelremoving 0.0191104 0.0928276 0.412107 0.0573303 0.0844827 30
end_path:calibanagnocchi:CalibAnaTree 0.258187 0.609338 1.77513 0.559574 0.302692 30
end_path:out1:RootOutput(write) 0.379782 0.671304 1.14053 0.631495 0.192616 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4933.66 MB
Peak resident set size usage (VmHWM): 2352.23 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236_reco_stage1_reco_stage2_20240926T105203_keepup.root
\tHists: np04hd_raw_run029081_0555_dataflow5_datawriter_0_20240905T013236_reco_stage1_reco_stage2_20240926T105203_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