Jobsub ID 272059.93@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/f8/ab/000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z.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 ===
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::FrameFanin : 57.02644 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 56.956448 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 56.88648 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 56.456535 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::FrameFanin : 56.356552 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 56.046604 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 55.936634 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 55.71667 sec
[16:26:40.547] I [ timer ] Timer: wcls::FrameSaver : 55.62667 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 55.226738 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 55.056767 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 55.046772 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Retagger : 54.956783 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::FrameFanin : 54.79681 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 54.506866 sec
[16:26:40.547] I [ timer ] Timer: WireCell::Gen::Reframer : 54.186916 sec
[16:26:40.547] I [ timer ] Timer: Total node execution : 10556.174728393555 sec
wclsFrameSaver: saving 34724 traces tagged "gauss"
FrameSaver: q=1.16135e+07 n=662995 tag=gauss
wclsFrameSaver: saving 43054 traces tagged "wiener"
FrameSaver: q=1.31972e+07 n=615113 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
09-Oct-2024 16:26:48 CEST Closed output file "000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z_reco_data_2024-10-09T_101221Z.root"
09-Oct-2024 16:26:48 CEST Closed input file "root://golias100.farm.particle.cz:1094/dpm/farm.particle.cz/home/dune/RSE/usertests/f8/ab/000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 132.3 1084.19 11487.4 223.238 2895.14 14
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000383576 0.00380457 0.0172496 0.00261722 0.00416502 14
simulate:tpcrawdecoder:WireCellToolkit 132.114 1077.91 11422.5 221.397 2878.82 14
simulate:opdigi:OpDetDigitizerDUNE 0.0746353 5.60183 60.9684 1.3209 15.4034 14
simulate:rns:RandomNumberSaver 4.5861e-05 0.000119066 0.000747172 4.9901e-05 0.000187554 14
[art]:TriggerResults:TriggerResultInserter 1.6571e-05 2.38298e-05 5.5771e-05 1.90605e-05 1.23949e-05 14
end_path:out1:RootOutput 6.47e-06 1.11273e-05 2.926e-05 8.12e-06 6.80787e-06 14
end_path:out1:RootOutput(write) 0.0580553 0.670385 3.91331 0.417689 0.96845 14
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 11999.1 MB
Peak resident set size usage (VmHWM): 9874.28 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 689490667
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 350398289
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 619195451
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z_reco_data_2024-10-09T_101221Z.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": 108,
"art.last_event": 995,
"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": 1728484008.0,
"core.event_count": 14,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 108,
"core.last_event_number": 995,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1728468941.0
},
"parents": [
{
"did": "usertests:000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z.root"
}
]
}
===================
.:
total 1527628
-rw-r--r--. 1 duneprd np-comp 1563022093 Oct 9 16:26 000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z_reco_data_2024-10-09T_101221Z.root
-rw-r--r--. 1 duneprd np-comp 626609 Oct 9 16:26 000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z_reco_2024-10-09T_101221Z.log
-rw-r--r--. 1 duneprd np-comp 611520 Oct 9 16:26 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r--. 1 duneprd np-comp 6133 Oct 9 16:26 jobscript.log
-rw-r--r--. 1 duneprd np-comp 1115 Oct 9 16:26 000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z_reco_data_2024-10-09T_101221Z.root.json
-rw-r--r--. 1 duneprd np-comp 930 Oct 9 16:26 000471_reco_data_2024-10-07T_115636Z_reco_data_2024-10-08T_094502Z_reco_data_2024-10-09T_101221Z.root.ext.json
-rw-r--r--. 1 duneprd np-comp 164 Oct 9 12:12 all-input-dids.txt
-rw-r--r--. 1 duneprd np-comp 162 Oct 9 16:26 justin-processed-pfns.txt
-rw-r--r--. 1 duneprd np-comp 0 Oct 9 12:12 debugprod.log 