Jobsub ID 78928.15@justin-prod-sched02.dune.hep.ac.uk
Jobsub ID | 78928.15@justin-prod-sched02.dune.hep.ac.uk |
Workflow ID | 3449 |
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:28:37 |
Site | IT_CNAF |
Entry | CMSHTPC_T1_IT_CNAF_condor_ce02 |
Last heartbeat | 2024-09-26 14:53:37 |
From worker node | Hostname | cn-leo-157.cr.cnaf.infn.it |
cpuinfo | Intel(R) Xeon(R) Platinum 8480+ |
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:35:00 |
Input files | hd-protodune:np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 14:53:37 |
Saved logs | justin-logs:78928.15-justin-prod-sched02.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
4415 potential space points
Neighbour search...
372351 tests to find 218322 neighbours
Iterating with no regularization...
Begin: 7.42724e+06
0 6.58502e+06
1 6.51999e+06
2 6.50645e+06
3 6.50166e+06
Now with regularization...
Begin: 6.01581e+06
0 6.01273e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 5 event 207623 TrkackID 2 startx, y, z 39.7171 589.01 299.7 wireno, peakt tpcno 21 39.8347 5 dist 1.7708min T, max_T17.4241 3331.87
no of hits closeby 6 event 207623 TrkackID 6 startx, y, z -77.5925 588.982 250.765 wireno, peakt tpcno 425 1606.63 6 dist 0min T, max_T1120.19 2128.64
no of hits closeby 5 event 207623 TrkackID 2 startx, y, z 39.7171 589.01 299.7 wireno, peakt tpcno 21 39.8347 5 dist 1.7708min T, max_T17.4241 3331.87
no of hits closeby 6 event 207623 TrkackID 6 startx, y, z -77.5925 588.982 250.765 wireno, peakt tpcno 425 1606.63 6 dist 0min T, max_T1120.19 2128.64
Begin processing the 29th record. run: 29107 subRun: 1 event: 207631 at 26-Sep-2024 16:50:00 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 43706 traces, 43706 summary
Retagger: tagging trace set: gauss with 33044 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 33044 traces tagged "gauss"
FrameSaver: q=685667 n=631942 tag=gauss
wclsFrameSaver: saving 43706 traces tagged "wiener"
FrameSaver: q=725870 n=570362 tag=wiener
2438 hits in TPC 0
2201 hits in TPC 1
2265 hits in TPC 2
1382 hits in TPC 3
3864 hits in TPC 4
6260 hits in TPC 5
3009 hits in TPC 6
2027 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 4 XUs and 2 XVs -> 0 XUVs
C:0 T:1 21 XUs and 11 XVs -> 1 XUVs
C:0 T:2 1933 XUs and 4352 XVs -> 82 XUVs
C:0 T:3 258 XUs and 536 XVs -> 31 XUVs
C:0 T:4 172 XUs and 230 XVs -> 15 XUVs
C:0 T:5 17186 XUs and 26765 XVs -> 652 XUVs
C:0 T:6 5931 XUs and 4146 XVs -> 153 XUVs
C:0 T:7 86 XUs and 91 XVs -> 4 XUVs
938 XUVs total
662 collection wire objects
938 potential space points
Neighbour search...
14124 tests to find 7942 neighbours
Iterating with no regularization...
Begin: 3.18868e+06
0 2.909e+06
1 2.90042e+06
2 2.89945e+06
Now with regularization...
Begin: 2.73259e+06
0 2.73222e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 30th record. run: 29107 subRun: 1 event: 207639 at 26-Sep-2024 16:51:29 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 60637 traces, 60637 summary
Retagger: tagging trace set: gauss with 44309 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 44309 traces tagged "gauss"
FrameSaver: q=958850 n=800043 tag=gauss
wclsFrameSaver: saving 60637 traces tagged "wiener"
FrameSaver: q=1.02167e+06 n=712768 tag=wiener
1240 hits in TPC 0
1779 hits in TPC 1
4064 hits in TPC 2
3497 hits in TPC 3
2446 hits in TPC 4
4178 hits in TPC 5
7264 hits in TPC 6
5689 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 312 XUs and 153 XVs -> 4 XUVs
C:0 T:2 8954 XUs and 9539 XVs -> 180 XUVs
C:0 T:3 117 XUs and 105 XVs -> 6 XUVs
C:0 T:4 20 XUs and 23 XVs -> 0 XUVs
C:0 T:5 22695 XUs and 13495 XVs -> 401 XUVs
C:0 T:6 36664 XUs and 36253 XVs -> 1202 XUVs
C:0 T:7 959 XUs and 883 XVs -> 33 XUVs
1826 XUVs total
961 collection wire objects
1826 potential space points
Neighbour search...
33964 tests to find 19768 neighbours
Iterating with no regularization...
Begin: 7.97952e+06
0 7.63619e+06
1 7.60112e+06
2 7.59704e+06
Now with regularization...
Begin: 7.13732e+06
0 7.13564e+06
BdtBeamParticleIdTool::SliceFeatures::GetLeadingCaloHits - empty calo hit list
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
26-Sep-2024 16:53:12 CEST Closed output file "np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1_reco_stage2_20240926T145312_keepup.root"
26-Sep-2024 16:53:12 CEST Closed input file "np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 82.2383 104.212 139.663 101.898 14.7617 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000565286 0.00283536 0.0118735 0.00222986 0.00238507 30
produce:fembfilter:PDHDFEMBFilter 0.691827 0.818871 1.02393 0.752839 0.127405 30
produce:wclsdatahd:WireCellToolkit 57.2319 60.67 64.3301 60.6162 1.88974 30
produce:gaushit:GausHitFinder 0.358737 0.564779 0.836416 0.542057 0.129014 30
produce:nhitsfilter:NumberOfHitsFilter 0.000397719 0.000588237 0.000785314 0.000584219 0.000114476 30
produce:reco3d:SpacePointSolver 0.199157 1.04305 2.41526 0.911576 0.638548 30
produce:hitpdune:DisambigFromSpacePoints 0.146143 0.346409 0.612998 0.320101 0.135478 30
produce:pandora:StandardPandora 4.33946 10.0995 17.1145 10.0271 3.82464 30
produce:pandoraWriter:StandardPandora 0.0960808 0.168377 0.294113 0.160305 0.0464644 30
produce:pandoraTrack:LArPandoraTrackCreation 0.623572 2.36732 4.81485 2.10992 0.998005 30
produce:pandoraShower:LArPandoraShowerCreation 0.597861 2.95893 6.68705 2.52575 1.48901 30
produce:pandoracalo:Calorimetry 0.324435 0.964981 1.84696 0.886822 0.38869 30
produce:pandoracalonosce:Calorimetry 0.273381 0.912543 1.86824 0.819381 0.398107 30
produce:pandorapid:Chi2ParticleID 0.00119716 0.00177307 0.00270579 0.00163609 0.000411324 30
produce:pandoraShowercalo:ShowerCalorimetry 0.51707 2.3658 5.38696 1.99507 1.2548 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.485443 2.3519 5.59246 1.94789 1.27893 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.067418 0.101148 0.168535 0.100421 0.0246013 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0261586 0.0444063 0.0716719 0.0438215 0.0115501 30
produce:emtrkmichelid:EmTrackMichelId 9.32091 16.3856 27.7325 16.3507 4.16583 30
[art]:TriggerResults:TriggerResultInserter 7.2761e-05 0.000115091 0.00018343 0.00010566 2.97149e-05 30
end_path:out1:RootOutput 2.1785e-05 3.73487e-05 7.0298e-05 3.4579e-05 1.2617e-05 30
end_path:michelremoving:michelremoving 0.0338245 0.100784 0.288028 0.0842758 0.0610992 30
end_path:michelremovinggnocchi:michelremoving 0.0203929 0.0902331 0.262186 0.0680471 0.0587793 30
end_path:calibanagnocchi:CalibAnaTree 0.212719 0.749226 1.38355 0.671097 0.303878 30
end_path:out1:RootOutput(write) 0.402062 0.682094 1.09309 0.665955 0.193642 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 5835.37 MB
Peak resident set size usage (VmHWM): 2647.52 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1_reco_stage2_20240926T145312_keepup.root
\tHists: np04hd_raw_run029107_0864_dataflow7_datawriter_0_20240907T044741_reco_stage1_reco_stage2_20240926T145312_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