Jobsub ID 260100.0@justin-prod-sched01.dune.hep.ac.uk
Jobscript log (last 10,000 characters)
<TFile::Append>: Replacing existing TH1: FieldResponse_U (Potential memory leak).
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_V (Potential memory leak).
Warning in <TFile::Append>: Replacing existing TH1: FieldResponse_Y (Potential memory leak).
Active Boundaries:
x: -363.376 to 363.376
y: -607.829 to 607.829
z: -0.87625 to 1393.46
20-Sep-2024 08:14:39 EDT Initiating request to open input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/54/0d/000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z.root"
Plugin version SecClnt v5.4.3 is incompatible with secztn v5.6.8 (must be <= 5.4.x) in sec.protocol libXrdSecztn-5.so
20-Sep-2024 08:14:45 EDT Opened input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/54/0d/000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z.root"
job begin...
Fiducial volume:
-353.376 < x < 353.376
-597.829 < y < 597.829
9.12375 < z < 1383.46
job begin...
Fiducial volume:
-353.376 < x < 353.376
-597.829 < y < 597.829
9.12375 < z < 1383.46
Begin processing the 1st record. run: 20000031 subRun: 0 event: 74 at 20-Sep-2024 08:14:47 EDT
Analysing.
Warning: there was no track found for track-like PFParticle with ID 0
Warning: there was no track found for track-like PFParticle with ID 1
Warning: there was no track found for track-like PFParticle with ID 2
Warning: there was no shower found for shower-like PFParticle with ID 3
Warning: there was no track found for track-like PFParticle with ID 4
Warning: there was no track found for track-like PFParticle with ID 5
Warning: there was no shower found for shower-like PFParticle with ID 6
20-Sep-2024 08:14:49 EDT Opened output file with pattern "000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z_reco_data_2024-09-20T_121423Z.root"
Begin processing the 2nd record. run: 20000031 subRun: 0 event: 110 at 20-Sep-2024 08:15:04 EDT
Analysing.
Warning: there was no track found for track-like PFParticle with ID 0
Warning: there was no shower found for shower-like PFParticle with ID 1
Warning: there was no track found for track-like PFParticle with ID 2
Warning: there was no shower found for shower-like PFParticle with ID 3
Warning: there was no shower found for shower-like PFParticle with ID 4
Warning: there was no track found for track-like PFParticle with ID 5
Warning: there was no shower found for shower-like PFParticle with ID 6
Warning: there was no track found for track-like PFParticle with ID 7
Warning: there was no track found for track-like PFParticle with ID 8
Warning: there was no shower found for shower-like PFParticle with ID 9
Warning: there was no track found for track-like PFParticle with ID 10
Warning: there was no shower found for shower-like PFParticle with ID 11
Warning: there was no track found for track-like PFParticle with ID 12
Warning: there was no shower found for shower-like PFParticle with ID 13
Warning: there was no track found for track-like PFParticle with ID 14
Warning: there was no shower found for shower-like PFParticle with ID 15
Warning: there was no track found for track-like PFParticle with ID 16
Warning: there was no track found for track-like PFParticle with ID 17
Warning: there was no track found for track-like PFParticle with ID 18
Warning: there was no shower found for shower-like PFParticle with ID 19
Warning: there was no track found for track-like PFParticle with ID 20
Warning: there was no track found for track-like PFParticle with ID 21
Warning: there was no track found for track-like PFParticle with ID 22
Warning: there was no track found for track-like PFParticle with ID 23
Warning: there was no vertex found for PFParticle with ID 24
Warning: there was no shower found for shower-like PFParticle with ID 24
Warning: there was no shower found for shower-like PFParticle with ID 25
Warning: there was no shower found for shower-like PFParticle with ID 26
Warning: there was no shower found for shower-like PFParticle with ID 27
Warning: there was no shower found for shower-like PFParticle with ID 28
Warning: there was no shower found for shower-like PFParticle with ID 29
Warning: there was no shower found for shower-like PFParticle with ID 30
20-Sep-2024 08:15:20 EDT Closed output file "000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z_reco_data_2024-09-20T_121423Z.root"
20-Sep-2024 08:15:20 EDT Closed input file "root://fndca1.fnal.gov:1094/pnfs/fnal.gov/usr/dune/persistent/staging/usertests/54/0d/000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z.root"
==============================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
==============================================================================================================================
Full event 15.0141 15.6742 16.3342 15.6742 0.660049 2
------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.0439654 0.047104 0.0502425 0.047104 0.00313857 2
end_path:out1:RootOutput 7.364e-06 5.59255e-05 0.000104487 5.59255e-05 4.85615e-05 2
end_path:analysistree:AnalysisTree 1.32899 1.35548 1.38197 1.35548 0.0264911 2
end_path:pandoraeff:NeutrinoTrackingEff 0.000489664 0.00180041 0.00311116 0.00180041 0.00131075 2
end_path:pandorashweff:NeutrinoShowerEff 9.0761e-05 0.00171709 0.00334341 0.00171709 0.00162633 2
end_path:runcheckereco:CheckRecoEnergy 1.9096e-05 0.000236917 0.000454738 0.000236917 0.000217821 2
end_path:flashmatchAna:FlashMatchAna 0.164922 0.181597 0.198271 0.181597 0.0166748 2
end_path:out1:RootOutput(write) 13.4356 14.0853 14.7351 14.0853 0.649722 2
==============================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2698.87 MB
Peak resident set size usage (VmHWM): 1375.01 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 200 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.w3317s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 74,
"art.last_event": 110,
"art.process_name": "Mergeana",
"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": "full-reconstructed",
"core.end_time": 1726834520.0,
"core.event_count": 2,
"core.file_format": "artroot",
"core.file_type": "mc",
"core.first_event_number": 74,
"core.last_event_number": 110,
"core.run_type": "physics",
"core.runs": [
20000031
],
"core.runs_subruns": [
2000003100000
],
"core.start_time": 1726834489.0
},
"parents": [
{
"did": "usertests:000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z.root"
}
]
}
===================
.:
total 23440
-rw-r--r-- 1 osgusers domain users 22613588 Sep 20 08:15 000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z_reco_data_2024-09-20T_121423Z.root
-rw-r--r-- 1 osgusers domain users 1343439 Sep 20 08:15 ana_hist.root
-rw-r--r-- 1 osgusers domain users 13321 Sep 20 08:15 jobscript.log
-rw-r--r-- 1 osgusers domain users 8793 Sep 20 08:15 000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z_reco_2024-09-20T_121423Z.log
-rw-r--r-- 1 osgusers domain users 1204 Sep 20 08:15 000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z_reco_data_2024-09-20T_121423Z.root.json
-rw-r--r-- 1 osgusers domain users 1107 Sep 20 08:15 000396_reco_data_2024-08-16T_162233Z_reco_data_2024-08-19T_140214Z_reco_data_2024-08-20T_115338Z_reco_data_2024-08-22T_092928Z_reco_data_2024-08-23T_100636Z_reco_data_2024-09-20T_121423Z.root.ext.json
-rw-r--r-- 1 osgusers domain users 344 Sep 20 08:14 all-input-dids.txt
-rw-r--r-- 1 osgusers domain users 248 Sep 20 08:15 justin-processed-pfns.txt
-rw-r--r-- 1 osgusers domain users 0 Sep 20 08:14 debugprod.log 