Jobsub ID 256942.7@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
AFM gen filter jobscript.
Input PFN = root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/usertests/2c/9c/000695_reco_data_2025-12-01T_121116Z.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_5_5a/Linux64bit+3.10-2.17-e26-p3915-prof/lib/libXrdPosixPreload.so
=== Start last 100 lines of lar log file ===
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 7
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w BackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 7
Rebuild failed to get the SimChannels. This is expected when running on a generation or simulation step.
%MSG
%MSG-w PhotonBackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 7
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
Begin processing the 8th record. run: 20000031 subRun: 0 event: 8 at 03-Dec-2025 15:54:05 CET
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 8
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 8
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 8
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w BackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 8
Rebuild failed to get the SimChannels. This is expected when running on a generation or simulation step.
%MSG
%MSG-w PhotonBackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 8
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
Begin processing the 9th record. run: 20000031 subRun: 0 event: 9 at 03-Dec-2025 15:54:05 CET
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 9
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 9
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 9
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w BackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 9
Rebuild failed to get the SimChannels. This is expected when running on a generation or simulation step.
%MSG
%MSG-w PhotonBackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 9
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
Begin processing the 10th record. run: 20000031 subRun: 0 event: 10 at 03-Dec-2025 15:54:05 CET
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 10
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 10
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w ParticleInventory: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 10
Rebuild failed to get the MCParticles. This is expected when running on a generation or simulation step.
%MSG
%MSG-w BackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 10
Rebuild failed to get the SimChannels. This is expected when running on a generation or simulation step.
%MSG
%MSG-w PhotonBackTrackerService: ProcessEvent 03-Dec-2025 15:54:05 CET run: 20000031 subRun: 0 event: 10
Rebuild failed to get the OpDetBTRs. This is expected when running on a generation or simulation step.
%MSG
03-Dec-2025 15:54:06 CET Closed output file "000695_reco_data_2025-12-01T_121116Z_reco_data_2025-12-03T_145349Z.root"
03-Dec-2025 15:54:06 CET Closed input file "root://otter12.grid.surfsara.nl:21094/pnfs/grid.sara.nl/data/dune/disk/RSE/usertests/2c/9c/000695_reco_data_2025-12-01T_121116Z.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.000306335 0.00188719 0.0152206 0.000427913 0.00444526 10
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 6.6335e-05 0.000277721 0.00184307 9.91465e-05 0.000522811 10
fpath:cosmicfilter:CosmicFilter 5.8931e-05 0.00073115 0.00652885 7.7761e-05 0.00193288 10
[art]:TriggerResults:TriggerResultInserter 1.3185e-05 2.94262e-05 0.000131056 1.4287e-05 3.55423e-05 10
end_path:out1:RootOutput 5.481e-06 4.0533e-05 0.000316303 6.442e-06 9.23468e-05 10
end_path:out1:RootOutput(write) 3.897e-06 0.000634894 0.00584525 4.4664e-05 0.00173778 10
================================================================================================================================
%MSG-i NuRandomService: RootOutput:out1@EndJob 03-Dec-2025 15:54:06 CET ModuleEndJob
Summary of seeds computed by the NuRandomService
Random policy: 'perEvent'
algorithm version: EventTimestamp_v1
%MSG
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 1366.21 MB
Peak resident set size usage (VmHWM): 597.488 MB
====================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 10 passed = 5 failed = 5
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 5 5 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 1.124168 Real = 1.528323
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 1366.21 VmHWM = 597.488
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
lar exit code 0
extractor_prod.py exit code 0
pdjson2metadata exit code 0
Metadata extraction succeeds
===Metadata JSON===
{
"metadata": {
"DUNE.campaign": "justIN.w10970s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 1,
"art.last_event": 10,
"art.process_name": "MUSUNFilter",
"art.run_type": "physics",
"core.application": "art.reco",
"core.application.family": "art",
"core.application.name": "reco",
"core.application.version": "v10_11_00d01",
"core.data_stream": "out1",
"core.data_tier": "generated",
"core.end_time": 1764773646.0,
"core.event_count": 5,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 1,
"core.last_event_number": 10,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1764773645.0
},
"parents": [
{
"did": "usertests:000695_reco_data_2025-12-01T_121116Z.root"
}
]
}
===================
.:
total 152
-rw-r--r-- 1 dune090 dune 99331 Dec 3 15:54 000695_reco_data_2025-12-01T_121116Z_reco_data_2025-12-03T_145349Z.root
-rw-r--r-- 1 dune090 dune 19109 Dec 3 15:54 000695_reco_data_2025-12-01T_121116Z_reco_2025-12-03T_145349Z.log
-rw-r--r-- 1 dune090 dune 8578 Dec 3 15:54 jobscript.log
-rw-r--r-- 1 dune090 dune 1075 Dec 3 15:54 000695_reco_data_2025-12-01T_121116Z_reco_data_2025-12-03T_145349Z.root.json
-rw-r--r-- 1 dune090 dune 855 Dec 3 15:54 000695_reco_data_2025-12-01T_121116Z_reco_data_2025-12-03T_145349Z.root.ext.json
-rw-r--r-- 1 dune090 dune 519 Dec 3 15:54 MUSUN_filter_hist.root
-rw-r--r-- 1 dune090 dune 133 Dec 3 15:54 justin-processed-pfns.txt
-rw-r--r-- 1 dune090 dune 104 Dec 3 15:53 all-input-dids.txt