justIN           Dashboard       Workflows       Jobs       AWT       Sites       Storages       Docs       Login

Jobsub ID 269292.71@justin-prod-sched01.dune.hep.ac.uk

Jobsub ID269292.71@justin-prod-sched01.dune.hep.ac.uk
Workflow ID3584
Stage ID1
User namecalcuttj@fnal.gov
HTCondor Groupgroup_dune.prod_mcsim
RequestedProcessors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit18000 (5 hours)
Submitted time2024-10-04 16:57:15
SiteUS_FNAL-FermiGrid
EntryFNAL_GPGrid_ce04_mcore_op_duneonly
Last heartbeat2024-10-04 21:42:59
From worker nodeHostnamedunegli-4177636-0-fnpc17148.fnal.gov
cpuinfoIntel(R) Xeon(R) Gold 6140 CPU @ 2.30GHz
OS releaseScientific Linux release 7.9 (Nitrogen)
Processors1
RSS bytes4193255424 (3999 MiB)
Wall seconds limit172800 (48 hours)
Inner Apptainer?True
Job statefinished
Allocator namejustin-allocator-pro.dune.hep.ac.uk
Started2024-10-04 18:16:49
Input fileshd-protodune:np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813.hdf5
JobscriptExit code0
Real time3h (12305s)
CPU time2h (9004s = 73%)
Outputting started2024-10-04 21:41:54
Output fileshd-protodune-det-reco:np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup.root
hd-protodune-det-reco:np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup_hists.root
Finished2024-10-04 21:42:59
Saved logsjustin-logs:269292.71-justin-prod-sched01.dune.hep.ac.uk.logs.tgz
List job events     Wrapper job log

Jobscript log (last 10,000 characters)

races tagged "gauss"
FrameSaver: q=1.94563e+06 n=991398 tag=gauss
wclsFrameSaver: saving 65164 traces tagged "wiener"
FrameSaver: q=2.13976e+06 n=926798 tag=wiener
4651 hits in TPC 0
5608 hits in TPC 1
9723 hits in TPC 2
7086 hits in TPC 3
3062 hits in TPC 4
7580 hits in TPC 5
4114 hits in TPC 6
2698 hits in TPC 7
0 X, 0 U, 0 V bad channels
Finding XUV coincidences...
C:0 T:1 13988 XUs and 9655 XVs -> 2118 XUVs
C:0 T:2 48421 XUs and 36947 XVs -> 2426 XUVs
C:0 T:3 151 XUs and 208 XVs -> 6 XUVs
C:0 T:4 105 XUs and 121 XVs -> 8 XUVs
C:0 T:5 72240 XUs and 47178 XVs -> 3689 XUVs
C:0 T:6 5773 XUs and 4923 XVs -> 166 XUVs
C:0 T:7 1832 XUs and 1392 XVs -> 61 XUVs
8474 XUVs total
2155 collection wire objects
8474 potential space points
Neighbour search...
604868 tests to find 311656 neighbours
Iterating with no regularization...
Begin: 5.0723e+07
0 4.33795e+07
1 4.29394e+07
2 4.28757e+07
3 4.28533e+07
Now with regularization...
Begin: 4.07734e+07
0 4.07587e+07
BdtBeamParticleIdTool::SliceFeatures::GetLArTPCIntercepts - inconsistent number of intercepts between a line and the LArTPC
---INTERPRETED-MATCHING-OUTPUT------------------------------------------------------------------
---SUMMARY--------------------------------------------------------------------------------------
------------------------------------------------------------------------------------------------

04-Oct-2024 21:41:40 UTC  Closed output file "np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup.root"
04-Oct-2024 21:41:40 UTC  Closed input file "np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1.root"

========================================================================================================================================
TimeTracker printout (sec)                                Min           Avg           Max         Median          RMS         nEvts   
========================================================================================================================================
Full event                                              53.3072       205.221       491.335       183.043       93.1767        40     
----------------------------------------------------------------------------------------------------------------------------------------
source:RootInput(read)                                0.000553396    0.010388      0.239476      0.0040425     0.0367541       40     
produce:fembfilter:PDHDFEMBFilter                       1.06703       1.5746        2.11927       1.6049       0.241047        40     
produce:wclsdatahd:WireCellToolkit                      49.0031       68.676        105.495       69.1694       10.8344        40     
produce:gaushit:GausHitFinder                          0.676108       1.46652       2.91337       1.39155      0.519685        40     
produce:nhitsfilter:NumberOfHitsFilter                0.000390998   0.000747549   0.00135166    0.000693142   0.000225533      40     
[art]:TriggerResults:TriggerResultInserter            4.2192e-05    7.83752e-05   0.000114464   7.8502e-05    1.48599e-05      40     
end_path:out1:RootOutput                               9.685e-06    2.08891e-05    4.089e-05    2.15325e-05   5.63171e-06      40     
end_path:michelremoving:michelremoving                7.7688e-05     0.189741       1.60178      0.0943456     0.295918        40     
end_path:michelremovinggnocchi:michelremoving         5.4393e-05      0.18641       1.58094      0.0944467     0.291793        40     
end_path:calibanagnocchi:CalibAnaTree                 5.6128e-05      2.4212        7.33221       2.04761       1.83494        40     
end_path:out1:RootOutput(write)                        0.442359       1.53461       3.02998       1.48842      0.614533        40     
produce:reco3d:SpacePointSolver                        0.404672       6.58151       37.8529       1.69186       9.82627        38     
produce:hitpdune:DisambigFromSpacePoints               0.426274       1.83281       6.49704       1.36364       1.46715        38     
produce:pandora:StandardPandora                         8.44441       41.5672       174.952       29.6001       33.9077        38     
produce:pandoraWriter:StandardPandora                  0.133447      0.347769      0.776543      0.318594      0.122123        38     
produce:pandoraTrack:LArPandoraTrackCreation            1.39484       7.47319       23.3895       6.45715       4.38673        38     
produce:pandoraShower:LArPandoraShowerCreation          1.72871       9.08469       28.321        7.2872        6.02887        38     
produce:pandoracalo:Calorimetry                        0.645995       3.11368       12.2677       2.68745       2.22791        38     
produce:pandoracalonosce:Calorimetry                   0.599154       2.95473       11.9044       2.51463       2.17262        38     
produce:pandorapid:Chi2ParticleID                     0.00161368    0.00376054    0.00832699    0.00364694    0.00121601       38     
produce:pandoraShowercalo:ShowerCalorimetry             1.47038       7.71483       30.4951       5.95806       6.11736        38     
produce:pandoraShowercalonosce:ShowerCalorimetry        1.47782       7.77937       27.7863       5.72255       6.42082        38     
produce:pandoraGnocchiCalo:GnocchiCalorimetry          0.106087      0.253866      0.595754      0.230285      0.115008        38     
produce:pandoraGnocchiCalonosce:GnocchiCalorimetry     0.0399035     0.104058      0.239733      0.0990666     0.0456172       38     
produce:emtrkmichelid:EmTrackMichelId                   27.2509       46.8318       87.5584       42.9028       15.9587        38     
========================================================================================================================================

====================================================================================================
MemoryTracker summary (base-10 MB units used)

  Peak virtual memory usage (VmPeak)  : 5049.08 MB
  Peak resident set size usage (VmHWM): 2716.02 MB
  Details saved in: 'mem.db'
====================================================================================================
Art has completed and will exit with status 0.
Output files:
\tReco: np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup.root
\tHists: np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup_hists.root
Forming reco metadata
Successfully opened file np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup.root
Ran successfully
{
  "name": "np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup.root",
  "namespace": "hd-protodune-det-reco",
  "metadata": {
    "core.file_format": "artroot",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v09_91_02d01",
    "core.data_tier": "full-reconstructed",
    "dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
    "dune.campaign": "hd-protodune-reco-keepup-v0",
    "core.start_time": 1728069836.0,
    "core.end_time": 1728078103.0,
    "core.events": [
      3241,
      3242,
      3243,
      3244,
      3245,
      3246,
      3247,
      3248,
      3249,
      3250,
      3251,
      3252,
      3253,
      3254,
      3255,
      3256,
      3257,
      3258,
      3259,
      3260,
      3261,
      3262,
      3263,
      3264,
      3265,
      3266,
      3267,
      3268,
      3269,
      3270,
      3271,
      3272,
      3273,
      3274,
      3275,
      3276,
      3277,
      3278,
      3279,
      3280
    ],
    "core.event_count": 40,
    "core.first_event_number": 3241,
    "core.last_event_number": 3280,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27704
    ],
    "core.runs_subruns": [
      2770400001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics",
    "origin.applications.config_files": {
      "reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
    },
    "origin.applications.versions": {
      "reco1": "v09_91_02d01"
    },
    "origin.applications.names": [
      "reco1"
    ]
  },
  "parents": [
    {
      "did": "hd-protodune:np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813.hdf5"
    }
  ]
}Forming hist metadata
formed
{
  "name": "np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813_reco_stage1_reco_stage2_20241004T214140_keepup_hists.root",
  "namespace": "hd-protodune-det-reco",
  "metadata": {
    "core.file_format": "root",
    "core.application.name": "reco",
    "core.application.family": "dunesw",
    "core.application.version": "v09_91_02d01",
    "core.data_tier": "root-tuple-virtual",
    "dune.config_file": "standard_reco_stage2_calibration_protodunehd_keepup.fcl",
    "dune.campaign": "hd-protodune-reco-keepup-v0",
    "core.start_time": 1728069836.0,
    "core.end_time": 1728078103.0,
    "core.data_stream": "cosmics",
    "core.file_content_status": "good",
    "core.file_type": "detector",
    "core.run_type": "hd-protodune",
    "core.runs": [
      27704
    ],
    "core.runs_subruns": [
      2770400001
    ],
    "dune.daq_test": false,
    "retention.status": "active",
    "retention.class": "physics",
    "origin.applications.config_files": {
      "reco1": "standard_reco_stage1_protodunehd_keepup.fcl"
    },
    "origin.applications.versions": {
      "reco1": "v09_91_02d01"
    },
    "origin.applications.names": [
      "reco1"
    ]
  },
  "parents": [
    {
      "did": "hd-protodune:np04hd_raw_run027704_0081_dataflow0_datawriter_0_20240705T033813.hdf5"
    }
  ]
}
justIN time: 2024-11-24 11:36:36 UTC       justIN version: 01.01.09