Jobsub ID 263763.117@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 263763.117@justin-prod-sched01.dune.hep.ac.uk |
Workflow ID | 3448 |
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:24:49 |
Site | ES_PIC |
Entry | DUNE_T1_ES_PIC_ce14-multicore |
Last heartbeat | 2024-09-26 14:39:47 |
From worker node | Hostname | tds222.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:26:00 |
Input files | hd-protodune:np04hd_raw_run029092_0909_dataflow3_datawriter_0_20240906T073040.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Outputting started | |
Output files | |
Finished | 2024-09-26 14:39:47 |
Saved logs | justin-logs:263763.117-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
XUs and 5358 XVs -> 298 XUVs
C:0 T:6 4006 XUs and 8578 XVs -> 234 XUVs
C:0 T:7 57 XUs and 101 XVs -> 12 XUVs
649 XUVs total
409 collection wire objects
649 potential space points
Neighbour search...
9121 tests to find 6108 neighbours
Iterating with no regularization...
Begin: 3.14119e+06
0 3.02586e+06
1 3.02142e+06
2 3.02126e+06
Now with regularization...
Begin: 2.8818e+06
0 2.88173e+06
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
Begin processing the 29th record. run: 29092 subRun: 1 event: 218387 at 26-Sep-2024 16:35:49 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 83181 traces, 83181 summary
Retagger: tagging trace set: gauss with 61814 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 61814 traces tagged "gauss"
FrameSaver: q=1.62638e+06 n=1128322 tag=gauss
wclsFrameSaver: saving 83181 traces tagged "wiener"
FrameSaver: q=1.78656e+06 n=1018412 tag=wiener
2927 hits in TPC 0
2804 hits in TPC 1
7412 hits in TPC 2
5483 hits in TPC 3
3480 hits in TPC 4
7744 hits in TPC 5
11412 hits in TPC 6
7760 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:0 10 XUs and 6 XVs -> 0 XUVs
C:0 T:1 3291 XUs and 4764 XVs -> 345 XUVs
C:0 T:2 41825 XUs and 45047 XVs -> 1699 XUVs
C:0 T:3 89 XUs and 156 XVs -> 4 XUVs
C:0 T:4 43 XUs and 7 XVs -> 0 XUVs
C:0 T:5 34732 XUs and 33946 XVs -> 1273 XUVs
C:0 T:6 77259 XUs and 112236 XVs -> 7180 XUVs
C:0 T:7 1025 XUs and 1545 XVs -> 27 XUVs
10528 XUVs total
3888 collection wire objects
10528 potential space points
Neighbour search...
2293874 tests to find 631900 neighbours
Iterating with no regularization...
Begin: 6.99844e+07
0 5.20864e+07
1 5.05972e+07
2 5.04337e+07
3 5.04021e+07
Now with regularization...
Begin: 4.37838e+07
0 4.36285e+07
1 4.36025e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 17 event 218387 TrkackID 6 startx, y, z -68.2741 594.884 181.649 wireno, peakt tpcno 228 2545.47 6 dist 26.0805min T, max_T2264.4 4937.23
no of hits closeby 17 event 218387 TrkackID 6 startx, y, z -68.2741 594.884 181.649 wireno, peakt tpcno 228 2545.47 6 dist 26.0805min T, max_T2264.4 4937.23
Begin processing the 30th record. run: 29092 subRun: 1 event: 218403 at 26-Sep-2024 16:37:45 CEST
RawFrameSource: got 10240 raw::RawDigit objects
input nticks=5859 keeping as is
Retagger: tagging trace set: wiener with 83999 traces, 83999 summary
Retagger: tagging trace set: gauss with 62624 traces, 0 summary
wclsFrameSaver saving cooked to 5859 ticks
wclsFrameSaver: saving 62624 traces tagged "gauss"
FrameSaver: q=1.46009e+06 n=1202868 tag=gauss
wclsFrameSaver: saving 83999 traces tagged "wiener"
FrameSaver: q=1.57172e+06 n=1097923 tag=wiener
1164 hits in TPC 0
1444 hits in TPC 1
11349 hits in TPC 2
6158 hits in TPC 3
3926 hits in TPC 4
7435 hits in TPC 5
10274 hits in TPC 6
5046 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 97 XUs and 63 XVs -> 4 XUVs
C:0 T:2 106863 XUs and 115043 XVs -> 2759 XUVs
C:0 T:3 53 XUs and 58 XVs -> 0 XUVs
C:0 T:4 112 XUs and 128 XVs -> 2 XUVs
C:0 T:5 20289 XUs and 18794 XVs -> 501 XUVs
C:0 T:6 71552 XUs and 104073 XVs -> 2340 XUVs
C:0 T:7 102 XUs and 103 XVs -> 8 XUVs
5614 XUVs total
2537 collection wire objects
5614 potential space points
Neighbour search...
232324 tests to find 142344 neighbours
Iterating with no regularization...
Begin: 1.7861e+07
0 1.63726e+07
1 1.62871e+07
2 1.62813e+07
Now with regularization...
Begin: 1.56143e+07
0 1.56117e+07
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------
no of hits closeby 4 event 218403 TrkackID 32 startx, y, z 66.1041 579.483 322.044 wireno, peakt tpcno 257 49.5069 5 dist 2.89437min T, max_T6.32891 804.904
no of hits closeby 4 event 218403 TrkackID 32 startx, y, z 66.1041 579.483 322.044 wireno, peakt tpcno 257 49.5069 5 dist 2.89437min T, max_T6.32891 804.904
26-Sep-2024 16:39:27 CEST Closed output file "np04hd_raw_run029092_0909_dataflow3_datawriter_0_20240906T073040_reco_stage1_reco_stage2_20240926T143927_keepup.root"
26-Sep-2024 16:39:27 CEST Closed input file "np04hd_raw_run029092_0909_dataflow3_datawriter_0_20240906T073040_reco_stage1.root"
========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
========================================================================================================================================
Full event 53.8084 80.9264 115.744 79.6496 13.6079 30
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000283624 0.00109689 0.00222781 0.00119665 0.000458613 30
produce:fembfilter:PDHDFEMBFilter 0.51792 0.542263 0.584618 0.540917 0.0157097 30
produce:wclsdatahd:WireCellToolkit 34.9707 37.367 42.8587 36.9887 1.77904 30
produce:gaushit:GausHitFinder 0.34217 0.667558 0.982978 0.692419 0.142672 30
produce:nhitsfilter:NumberOfHitsFilter 0.000122876 0.000243862 0.000387094 0.000241706 6.39332e-05 30
produce:reco3d:SpacePointSolver 0.0727783 0.822581 1.95098 0.67969 0.530619 30
produce:hitpdune:DisambigFromSpacePoints 0.0912146 0.549778 1.30057 0.510031 0.286862 30
produce:pandora:StandardPandora 3.05927 12.467 31.4587 11.3921 5.89354 30
produce:pandoraWriter:StandardPandora 0.046276 0.112094 0.166585 0.116503 0.0263898 30
produce:pandoraTrack:LArPandoraTrackCreation 0.330418 0.97716 2.65542 0.945598 0.439023 30
produce:pandoraShower:LArPandoraShowerCreation 0.301259 1.19233 2.61502 1.07766 0.56155 30
produce:pandoracalo:Calorimetry 0.192827 0.515655 1.11382 0.499282 0.185328 30
produce:pandoracalonosce:Calorimetry 0.169571 0.470451 1.08072 0.456076 0.180361 30
produce:pandorapid:Chi2ParticleID 0.000913942 0.0015342 0.00279818 0.00142128 0.000427998 30
produce:pandoraShowercalo:ShowerCalorimetry 0.272275 1.05185 2.05579 1.0489 0.437809 30
produce:pandoraShowercalonosce:ShowerCalorimetry 0.26626 1.0244 1.95078 1.0087 0.426258 30
produce:pandoraGnocchiCalo:GnocchiCalorimetry 0.0516012 0.113083 0.167935 0.110568 0.027588 30
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry 0.0165188 0.0382521 0.0573269 0.037796 0.00918711 30
produce:emtrkmichelid:EmTrackMichelId 9.51949 21.7333 29.9206 22.5076 4.66697 30
[art]:TriggerResults:TriggerResultInserter 1.4544e-05 1.79011e-05 5.5228e-05 1.62865e-05 7.0994e-06 30
end_path:out1:RootOutput 6.039e-06 8.2828e-06 2.3705e-05 7.025e-06 3.78216e-06 30
end_path:michelremoving:michelremoving 0.016261 0.0864439 0.36764 0.0290157 0.0951773 30
end_path:michelremovinggnocchi:michelremoving 0.0141997 0.084797 0.364309 0.0260396 0.0965993 30
end_path:calibanagnocchi:CalibAnaTree 0.153096 0.395809 0.966357 0.382608 0.164235 30
end_path:out1:RootOutput(write) 0.283358 0.66495 0.926016 0.679564 0.154758 30
========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4953.75 MB
Peak resident set size usage (VmHWM): 2606.23 MB
Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run029092_0909_dataflow3_datawriter_0_20240906T073040_reco_stage1_reco_stage2_20240926T143927_keepup.root
\tHists: np04hd_raw_run029092_0909_dataflow3_datawriter_0_20240906T073040_reco_stage1_reco_stage2_20240926T143927_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