Jobsub ID 293869.16@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
AFM detsim jobscript.
Input PFN = root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/03/09/000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z.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 ===
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::Reframer : 56.298176 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::Reframer : 56.23819 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::Reframer : 56.198166 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::Reframer : 56.128185 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::Reframer : 56.03822 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::Reframer : 55.938194 sec
[08:05:30.230] I [ timer ] Timer: wcls::SimDepoSource : 33.210434 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::DumpFrames : 31.950636 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::FrameFanin : 31.830633 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::FrameFanin : 31.820633 sec
[08:05:30.230] I [ timer ] Timer: wcls::FrameSaver : 31.350622 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 30.960613 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::FrameFanin : 30.300598 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 30.100594 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::DepoSetFanout : 29.93059 sec
[08:05:30.230] I [ timer ] Timer: WireCell::Gen::Retagger : 29.640583 sec
[08:05:30.230] I [ timer ] Timer: Total node execution : 146200.52862548828 sec
wclsFrameSaver: saving 894 traces tagged "gauss"
FrameSaver: q=18716.7 n=10371 tag=gauss
wclsFrameSaver: saving 883 traces tagged "wiener"
FrameSaver: q=28923.3 n=10473 tag=wiener
wclsFrameSaver: no traces tagged "dnnsp"
FrameSaver: q=0 n=0 tag=dnnsp
20-Nov-2024 08:05:32 CET Closed output file "000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z_reco_data_2024-11-18T_125550Z.root"
20-Nov-2024 08:05:32 CET Closed input file "root://meitner.tier2.hep.manchester.ac.uk:1094//cephfs/experiments/dune/RSE/usertests/03/09/000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 99.4303 150.48 494.44 137.001 45.2643 1000
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000250056 0.0156527 2.26927 0.000481105 0.111322 1000
simulate:tpcrawdecoder:WireCellToolkit 98.8899 150.221 491.715 136.828 45.0809 1000
simulate:opdigi:OpDetDigitizerDUNE 0.000240859 0.17111 3.36525 0.00102446 0.37708 1000
simulate:rns:RandomNumberSaver 1.731e-05 3.58755e-05 0.000305128 3.2982e-05 1.19936e-05 1000
[art]:TriggerResults:TriggerResultInserter 9.796e-06 1.50588e-05 7.1461e-05 1.3381e-05 4.78839e-06 1000
end_path:out1:RootOutput 2.658e-06 5.89684e-06 2.8514e-05 5.458e-06 1.76333e-06 1000
end_path:out1:RootOutput(write) 0.0341405 0.0716355 0.803431 0.042607 0.0760069 1000
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 4103.37 MB
Peak resident set size usage (VmHWM): 2309.94 MB
====================================================================================================
ProvidedPedestalAdditionService::dtor: Deleting random engine with seed 529279543
ExponentialChannelNoiseService::dtor: Deleting random engine with seed 752980734
StuckBitAdcDistortionService:dtor: Deleting random engine with seed 66002346
Art has completed and will exit with status 0.
=== End last 50 lines of lar log file ===
lar exit code 0
outfile is 000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z_reco_data_2024-11-18T_125550Z.root
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
"metadata": {
"DUNE.campaign": "justIN.w4131s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 1,
"art.last_event": 1000,
"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": 1732086332.0,
"core.event_count": 1000,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 1,
"core.last_event_number": 1000,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1731934906.0
},
"parents": [
{
"did": "usertests:000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z.root"
}
]
}
===================
.:
total 2255312
-rw-r--r-- 1 dune001 dune 2232830272 Nov 20 08:05 000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z_reco_data_2024-11-18T_125550Z.root
-rw-r--r-- 1 dune001 dune 38603821 Nov 20 08:05 000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z_reco_2024-11-18T_125550Z.log
-rw-r--r-- 1 dune001 dune 37965136 Nov 20 08:05 wcls-sim-drift-simchannel-nf-sp.log
-rw-r--r-- 1 dune001 dune 6120 Nov 20 08:05 jobscript.log
-rw-r--r-- 1 dune001 dune 1115 Nov 20 08:05 000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z_reco_data_2024-11-18T_125550Z.root.json
-rw-r--r-- 1 dune001 dune 930 Nov 20 08:05 000712_reco_data_2024-11-14T_093334Z_reco_data_2024-11-14T_135627Z_reco_data_2024-11-18T_125550Z.root.ext.json
-rw-r--r-- 1 dune001 dune 164 Nov 18 13:55 all-input-dids.txt
-rw-r--r-- 1 dune001 dune 164 Nov 20 08:05 justin-processed-pfns.txt
-rw-r--r-- 1 dune001 dune 0 Nov 18 13:56 debugprod.log 