Jobsub ID 33914.181@dunegpschedd02.fnal.gov
Jobscript log (last 10,000 characters)
ent: 70830 at 05-Sep-2025 06:40:25 CEST
Begin processing the 31st record. run: 6406500 subRun: 1 event: 70831 at 05-Sep-2025 06:40:26 CEST
Begin processing the 32nd record. run: 6406500 subRun: 1 event: 70832 at 05-Sep-2025 06:40:26 CEST
Begin processing the 33rd record. run: 6406500 subRun: 1 event: 70833 at 05-Sep-2025 06:40:28 CEST
Begin processing the 34th record. run: 6406500 subRun: 1 event: 70834 at 05-Sep-2025 06:40:28 CEST
Begin processing the 35th record. run: 6406500 subRun: 1 event: 70835 at 05-Sep-2025 06:40:28 CEST
Begin processing the 36th record. run: 6406500 subRun: 1 event: 70836 at 05-Sep-2025 06:40:28 CEST
Begin processing the 37th record. run: 6406500 subRun: 1 event: 70837 at 05-Sep-2025 06:40:29 CEST
Begin processing the 38th record. run: 6406500 subRun: 1 event: 70838 at 05-Sep-2025 06:40:29 CEST
Begin processing the 39th record. run: 6406500 subRun: 1 event: 70839 at 05-Sep-2025 06:40:29 CEST
Begin processing the 40th record. run: 6406500 subRun: 1 event: 70840 at 05-Sep-2025 06:40:29 CEST
Begin processing the 41st record. run: 6406500 subRun: 1 event: 70841 at 05-Sep-2025 06:40:29 CEST
Begin processing the 42nd record. run: 6406500 subRun: 1 event: 70842 at 05-Sep-2025 06:40:29 CEST
Begin processing the 43rd record. run: 6406500 subRun: 1 event: 70843 at 05-Sep-2025 06:40:33 CEST
Begin processing the 44th record. run: 6406500 subRun: 1 event: 70844 at 05-Sep-2025 06:40:34 CEST
Begin processing the 45th record. run: 6406500 subRun: 1 event: 70845 at 05-Sep-2025 06:40:34 CEST
Begin processing the 46th record. run: 6406500 subRun: 1 event: 70846 at 05-Sep-2025 06:40:34 CEST
Begin processing the 47th record. run: 6406500 subRun: 1 event: 70847 at 05-Sep-2025 06:40:34 CEST
Begin processing the 48th record. run: 6406500 subRun: 1 event: 70848 at 05-Sep-2025 06:40:34 CEST
Begin processing the 49th record. run: 6406500 subRun: 1 event: 70849 at 05-Sep-2025 06:40:34 CEST
Begin processing the 50th record. run: 6406500 subRun: 1 event: 70850 at 05-Sep-2025 06:40:34 CEST
Begin processing the 51st record. run: 6406500 subRun: 1 event: 70851 at 05-Sep-2025 06:40:34 CEST
Begin processing the 52nd record. run: 6406500 subRun: 1 event: 70852 at 05-Sep-2025 06:40:34 CEST
Begin processing the 53rd record. run: 6406500 subRun: 1 event: 70853 at 05-Sep-2025 06:40:35 CEST
Begin processing the 54th record. run: 6406500 subRun: 1 event: 70854 at 05-Sep-2025 06:40:35 CEST
Begin processing the 55th record. run: 6406500 subRun: 1 event: 70855 at 05-Sep-2025 06:40:35 CEST
Begin processing the 56th record. run: 6406500 subRun: 1 event: 70856 at 05-Sep-2025 06:40:35 CEST
Begin processing the 57th record. run: 6406500 subRun: 1 event: 70857 at 05-Sep-2025 06:40:35 CEST
Begin processing the 58th record. run: 6406500 subRun: 1 event: 70858 at 05-Sep-2025 06:40:35 CEST
Begin processing the 59th record. run: 6406500 subRun: 1 event: 70859 at 05-Sep-2025 06:40:38 CEST
Begin processing the 60th record. run: 6406500 subRun: 1 event: 70860 at 05-Sep-2025 06:40:38 CEST
Begin processing the 61st record. run: 6406500 subRun: 1 event: 70861 at 05-Sep-2025 06:40:39 CEST
Begin processing the 62nd record. run: 6406500 subRun: 1 event: 70862 at 05-Sep-2025 06:40:39 CEST
Begin processing the 63rd record. run: 6406500 subRun: 1 event: 70863 at 05-Sep-2025 06:40:39 CEST
Begin processing the 64th record. run: 6406500 subRun: 1 event: 70864 at 05-Sep-2025 06:40:39 CEST
Begin processing the 65th record. run: 6406500 subRun: 1 event: 70865 at 05-Sep-2025 06:40:39 CEST
Begin processing the 66th record. run: 6406500 subRun: 1 event: 70866 at 05-Sep-2025 06:40:42 CEST
Begin processing the 67th record. run: 6406500 subRun: 1 event: 70867 at 05-Sep-2025 06:40:42 CEST
Begin processing the 68th record. run: 6406500 subRun: 1 event: 70868 at 05-Sep-2025 06:40:42 CEST
Begin processing the 69th record. run: 6406500 subRun: 1 event: 70869 at 05-Sep-2025 06:40:43 CEST
Begin processing the 70th record. run: 6406500 subRun: 1 event: 70870 at 05-Sep-2025 06:40:43 CEST
Begin processing the 71st record. run: 6406500 subRun: 1 event: 70871 at 05-Sep-2025 06:40:43 CEST
Begin processing the 72nd record. run: 6406500 subRun: 1 event: 70872 at 05-Sep-2025 06:40:43 CEST
Begin processing the 73rd record. run: 6406500 subRun: 1 event: 70873 at 05-Sep-2025 06:40:43 CEST
Begin processing the 74th record. run: 6406500 subRun: 1 event: 70874 at 05-Sep-2025 06:40:43 CEST
Begin processing the 75th record. run: 6406500 subRun: 1 event: 70875 at 05-Sep-2025 06:40:43 CEST
Begin processing the 76th record. run: 6406500 subRun: 1 event: 70876 at 05-Sep-2025 06:40:44 CEST
Begin processing the 77th record. run: 6406500 subRun: 1 event: 70877 at 05-Sep-2025 06:40:44 CEST
Begin processing the 78th record. run: 6406500 subRun: 1 event: 70878 at 05-Sep-2025 06:40:44 CEST
Begin processing the 79th record. run: 6406500 subRun: 1 event: 70879 at 05-Sep-2025 06:40:45 CEST
Begin processing the 80th record. run: 6406500 subRun: 1 event: 70880 at 05-Sep-2025 06:40:45 CEST
Begin processing the 81st record. run: 6406500 subRun: 1 event: 70881 at 05-Sep-2025 06:40:47 CEST
Begin processing the 82nd record. run: 6406500 subRun: 1 event: 70882 at 05-Sep-2025 06:40:48 CEST
Begin processing the 83rd record. run: 6406500 subRun: 1 event: 70883 at 05-Sep-2025 06:40:48 CEST
Begin processing the 84th record. run: 6406500 subRun: 1 event: 70884 at 05-Sep-2025 06:40:49 CEST
Begin processing the 85th record. run: 6406500 subRun: 1 event: 70885 at 05-Sep-2025 06:40:49 CEST
Begin processing the 86th record. run: 6406500 subRun: 1 event: 70886 at 05-Sep-2025 06:40:49 CEST
Begin processing the 87th record. run: 6406500 subRun: 1 event: 70887 at 05-Sep-2025 06:40:49 CEST
Begin processing the 88th record. run: 6406500 subRun: 1 event: 70888 at 05-Sep-2025 06:40:49 CEST
Begin processing the 89th record. run: 6406500 subRun: 1 event: 70889 at 05-Sep-2025 06:40:50 CEST
Begin processing the 90th record. run: 6406500 subRun: 1 event: 70890 at 05-Sep-2025 06:40:50 CEST
Begin processing the 91st record. run: 6406500 subRun: 1 event: 70891 at 05-Sep-2025 06:40:51 CEST
Begin processing the 92nd record. run: 6406500 subRun: 1 event: 70892 at 05-Sep-2025 06:40:52 CEST
Begin processing the 93rd record. run: 6406500 subRun: 1 event: 70893 at 05-Sep-2025 06:40:52 CEST
Begin processing the 94th record. run: 6406500 subRun: 1 event: 70894 at 05-Sep-2025 06:40:53 CEST
Begin processing the 95th record. run: 6406500 subRun: 1 event: 70895 at 05-Sep-2025 06:40:53 CEST
Begin processing the 96th record. run: 6406500 subRun: 1 event: 70896 at 05-Sep-2025 06:40:53 CEST
Begin processing the 97th record. run: 6406500 subRun: 1 event: 70897 at 05-Sep-2025 06:40:54 CEST
Begin processing the 98th record. run: 6406500 subRun: 1 event: 70898 at 05-Sep-2025 06:40:54 CEST
Begin processing the 99th record. run: 6406500 subRun: 1 event: 70899 at 05-Sep-2025 06:40:54 CEST
Begin processing the 100th record. run: 6406500 subRun: 1 event: 70900 at 05-Sep-2025 06:40:54 CEST
05-Sep-2025 06:40:55 CEST Closed input file "root://dune.dcache.nikhef.nl:1094/pnfs/nikhef.nl/data/dune/generic/rucio/fardet-hd/c9/bb/atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_708_20231202T130250Z_gen_g4_detsim_hitreco__20240507T222031Z_reco2.root"
================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
================================================================================================================================
Full event 0.0279095 0.245786 3.14969 0.0672084 0.514156 100
--------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read) 0.000585242 0.00108785 0.0054196 0.0010052 0.000512971 100
prod:pandorapid:Chi2ParticleID 0.00127499 0.00476648 0.0311537 0.00287506 0.00507499 100
prod:energyreconue:EnergyReco 0.00568154 0.0273598 0.236144 0.012624 0.0420825 100
prod:energyreconumu:EnergyReco 0.00153688 0.092924 2.7012 0.0118324 0.326606 100
prod:energyreconc:EnergyReco 0.00369291 0.0232957 0.163152 0.0141613 0.0282938 100
[art]:TriggerResults:TriggerResultInserter 1.2584e-05 1.46501e-05 9.2093e-05 1.3721e-05 7.83462e-06 100
end_path:ana:PIDASelectionAna 0.0037512 0.0958877 1.39062 0.0248888 0.212409 100
================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 6760.43 MB
Peak resident set size usage (VmHWM): 1291.07 MB
====================================================================================================
Art has completed and will exit with status 0.
=== End last 100 lines of lar log file ===
.:
total 56
-rw-r--r--. 1 dune012 dune 20312 Sep 5 06:40 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_708_20231202T130250Z_gen_g4_detsim_hitreco__20240507T222031Z_reco2_pida_2025-09-05T_043959Z.root
-rw-r--r--. 1 dune012 dune 14308 Sep 5 06:40 atmnu_max_weighted_randompolicy_dune10kt_1x2x6_6406500_708_20231202T130250Z_gen_g4_detsim_hitreco__20240507T222031Z_reco2_reco_2025-09-05T_043959Z.log
-rw-r--r--. 1 dune012 dune 12032 Sep 5 06:40 jobscript.log
-rw-r--r--. 1 dune012 dune 216 Sep 5 06:40 justin-processed-pfns.txt
-rw-r--r--. 1 dune012 dune 137 Sep 5 06:39 all-input-dids.txt
-rw-r--r--. 1 dune012 dune 0 Sep 5 06:40 debugprod.log