Jobsub ID 272057.6@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/ed/9a/000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z.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 ===
[14:29:24.322] I [ timer ] Timer: wcls::FrameSaver : 45.668343 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 45.638393 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 45.618397 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 45.178474 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::FrameFanin : 45.058445 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 45.038498 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::FrameFanin : 45.02845 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 44.82853 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 44.778545 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 44.728554 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 44.598522 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Retagger : 44.24858 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 43.98868 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 43.91868 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 43.498707 sec
[14:29:24.322] I [ timer ] Timer: WireCell::Gen::Reframer : 43.44877 sec
[14:29:24.322] I [ timer ] Timer: Total node execution : 9623.847759246826 sec
wclsFrameSaver: saving 918 traces tagged "gauss"
FrameSaver: q=19800.5 n=10558 tag=gauss
wclsFrameSaver: saving 899 traces tagged "wiener"
FrameSaver: q=30282.3 n=10653 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
09-Oct-2024 14:29:25 BST Closed output file "000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z_reco_data_2024-10-09T_094324Z.root"
09-Oct-2024 14:29:25 BST Closed input file "root://mover.pp.rl.ac.uk:1094/pnfs/pp.rl.ac.uk/data/dune/usertests/ed/9a/000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 139.38 891.364 10231.7 208.45 2497.33 15
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000347654 0.00985108 0.124946 0.00172747 0.0307732 15
simulate:tpcrawdecoder:WireCellToolkit 139.053 888.011 10196.8 207.192 2488.87 15
simulate:opdigi:OpDetDigitizerDUNE 0.0157002 2.83214 31.1489 0.830553 7.59333 15
simulate:rns:RandomNumberSaver 2.4196e-05 5.00777e-05 0.000315213 3.0267e-05 7.10656e-05 15
[art]:TriggerResults:TriggerResultInserter 1.1872e-05 2.02487e-05 5.9211e-05 1.6091e-05 1.21856e-05 15
end_path:out1:RootOutput 3.677e-06 5.72267e-06 2.4906e-05 4.339e-06 5.13786e-06 15
end_path:out1:RootOutput(write) 0.0719568 0.510457 3.80253 0.262741 0.903437 15
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 10742.4 MB
Peak resident set size usage (VmHWM): 8204.4 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 763927324
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 371298268
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 650345878
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z_reco_data_2024-10-09T_094324Z.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": 33,
"art.last_event": 935,
"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": 1728480565.0,
"core.event_count": 15,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 33,
"core.last_event_number": 935,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1728467243.0
},
"parents": [
{
"did": "usertests:000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z.root"
}
]
}
===================
.:
total 1065100
-rw-r--r-- 1 dune01 dune01 1089310896 Oct 9 14:29 000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z_reco_data_2024-10-09T_094324Z.root
-rw-r--r-- 1 dune01 dune01 661842 Oct 9 14:29 000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z_reco_2024-10-09T_094324Z.log
-rw-r--r-- 1 dune01 dune01 646040 Oct 9 14:29 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 dune01 dune01 6071 Oct 9 14:29 jobscript.log
-rw-r--r-- 1 dune01 dune01 1113 Oct 9 14:29 000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z_reco_data_2024-10-09T_094324Z.root.json
-rw-r--r-- 1 dune01 dune01 928 Oct 9 14:29 000251_reco_data_2024-10-07T_115141Z_reco_data_2024-10-08T_085256Z_reco_data_2024-10-09T_094324Z.root.ext.json
-rw-r--r-- 1 dune01 dune01 164 Oct 9 10:43 all-input-dids.txt
-rw-r--r-- 1 dune01 dune01 145 Oct 9 14:29 justin-processed-pfns.txt
-rw-r--r-- 1 dune01 dune01 0 Oct 9 10:43 debugprod.log 