Jobsub ID 272059.54@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/usertests/87/b2/000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z.root
Setting up larsoft UPS area... /cvmfs/larsoft.opensciencegrid.org
Setting up DUNE UPS area... /cvmfs/dune.opensciencegrid.org/products/dune/
/cvmfs/larsoft.opensciencegrid.org/products/xrootd/v5_4_3b/Linux64bit+3.10-2.17-e20-p3913-prof/lib/libXrdPosixPreload.so
=== Start last 50 lines of lar log file ===
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::Reframer : 50.44755 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::Reframer : 50.407562 sec
[15:45:46.345] I [ timer ] Timer: wcls::FrameSaver : 50.187584 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::Reframer : 49.95771 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::FrameFanin : 49.85765 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::Reframer : 49.747673 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::Reframer : 49.74767 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::FrameFanin : 49.517708 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::Reframer : 49.297745 sec
[15:45:46.345] I [ timer ] Timer: WireCell::Gen::Reframer : 49.177776 sec
[15:45:46.346] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 49.14776 sec
[15:45:46.346] I [ timer ] Timer: WireCell::Gen::Retagger : 49.047775 sec
[15:45:46.346] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 48.857807 sec
[15:45:46.346] I [ timer ] Timer: WireCell::Gen::Reframer : 48.807823 sec
[15:45:46.346] I [ timer ] Timer: wcls::SimDepoSource : 48.697838 sec
[15:45:46.346] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 48.277905 sec
[15:45:46.346] I [ timer ] Timer: Total node execution : 8862.736339569092 sec
wclsFrameSaver: saving 8772 traces tagged "gauss"
FrameSaver: q=1.33513e+06 n=143142 tag=gauss
wclsFrameSaver: saving 10681 traces tagged "wiener"
FrameSaver: q=1.39764e+06 n=127530 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
09-Oct-2024 15:45:48 CEST Closed output file "000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z_reco_data_2024-10-09T_100941Z.root"
09-Oct-2024 15:45:48 CEST Closed input file "root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/usertests/87/b2/000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 92.3019 1074.68 10322.9 184.053 2796.21 12
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000528906 0.00308492 0.0167292 0.00190449 0.00421273 12
simulate:tpcrawdecoder:WireCellToolkit 91.9273 1067.51 10251 183.134 2776.64 12
simulate:opdigi:OpDetDigitizerDUNE 0.109849 6.48231 67.272 0.670331 18.3552 12
simulate:rns:RandomNumberSaver 4.155e-05 7.89649e-05 0.000315803 4.9801e-05 7.5282e-05 12
[art]:TriggerResults:TriggerResultInserter 1.303e-05 2.79021e-05 7.2091e-05 1.9445e-05 1.82488e-05 12
end_path:out1:RootOutput 5.72e-06 8.59342e-06 2.616e-05 6.23e-06 5.67588e-06 12
end_path:out1:RootOutput(write) 0.0500136 0.686439 4.67905 0.246508 1.25028 12
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 10864.7 MB
Peak resident set size usage (VmHWM): 8793.98 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 753088623
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 757487403
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 813267334
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z_reco_data_2024-10-09T_100941Z.root
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
"metadata": {
"DUNE.campaign": "justIN.w3659s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 51,
"art.last_event": 901,
"art.process_name": "detsim",
"art.run_type": "physics",
"core.application": "art.reco",
"core.application.family": "art",
"core.application.name": "reco",
"core.application.version": "v09_75_03d00",
"core.data_stream": "out1",
"core.data_tier": "detector-simulated",
"core.end_time": 1728481548.0,
"core.event_count": 12,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 51,
"core.last_event_number": 901,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1728468913.0
},
"parents": [
{
"did": "usertests:000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z.root"
}
]
}
===================
.:
total 1390264
-rw-r--r--. 1 duneprd np-comp 1422509987 Oct 9 15:45 000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z_reco_data_2024-10-09T_100941Z.root
-rw-r--r--. 1 duneprd np-comp 547797 Oct 9 15:45 000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z_reco_2024-10-09T_100941Z.log
-rw-r--r--. 1 duneprd np-comp 534084 Oct 9 15:45 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r--. 1 duneprd np-comp 6123 Oct 9 15:45 jobscript.log
-rw-r--r--. 1 duneprd np-comp 1113 Oct 9 15:45 000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z_reco_data_2024-10-09T_100941Z.root.json
-rw-r--r--. 1 duneprd np-comp 928 Oct 9 15:45 000140_reco_data_2024-10-07T_114853Z_reco_data_2024-10-08T_104626Z_reco_data_2024-10-09T_100941Z.root.ext.json
-rw-r--r--. 1 duneprd np-comp 164 Oct 9 12:09 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 162 Oct 9 15:45 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Oct 9 12:09 debugprod.log 