Jobsub ID 259737.11@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 259737.11@justin-prod-sched01.dune.hep.ac.uk |
| Workflow ID | 3310 |
| Stage ID | 1 |
| User name | dmunoz@fnal.gov |
| HTCondor Group | group_dune |
| Requested | Processors | 1 |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 80000 (22 hours) |
| Submitted time | 2024-09-19 21:22:30 |
| Site | UK_Edinburgh |
| Entry | DUNE_UK_SGridECDF_ce1_multicore |
| Last heartbeat | 2024-09-19 21:28:01 |
| From worker node | Hostname | node3a01.ecdf.ed.ac.uk |
| cpuinfo | Intel(R) Xeon(R) Gold 6242 CPU @ 2.80GHz |
| OS release | Scientific Linux release 7.9 (Nitrogen) |
| Processors | 1 |
| RSS bytes | 4194304000 (4000 MiB) |
| Wall seconds limit | 171000 (47 hours) |
| Inner Apptainer? | True |
| Job state | finished |
| Allocator name | justin-allocator-pro.dune.hep.ac.uk |
| Started | 2024-09-19 21:24:10 |
| Input files | justin-tutorial:tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712.hdf5
|
| Jobscript | Exit code | 0 |
| Real time | 3m (206s) |
| CPU time | 2m (133s = 64%) |
| Outputting started | 2024-09-19 21:27:37 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/dmunoz/03310/1/tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712_reco_data_2024-09-19T_212418Z.root
|
| Finished | 2024-09-19 21:28:01 |
| Saved logs | justin-logs:259737.11-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
9 22:27:30.230431 +0100][Debug ][ExDbgMsg ][ 1283] [se81.in.tier2.hep.manchester.ac.uk:1095] Moving MsgHandler: 0x10b5e720 (message: kXR_close (handle: 0x00000000) ) from out-queu to in-queue.
[2024-09-19 22:27:30.236998 +0100][Debug ][ExDbgMsg ][ 1283] [msg: 0xbf0b930] Assigned MsgHandler: 0x10b5e720.
[2024-09-19 22:27:30.237057 +0100][Debug ][ExDbgMsg ][ 1283] [handler: 0x10b5e720] Removed MsgHandler: 0x10b5e720 from the in-queue.
[2024-09-19 22:27:30.237189 +0100][Debug ][ExDbgMsg ][ 1283] [se81.in.tier2.hep.manchester.ac.uk:1095] Calling MsgHandler: 0x10b5e720 (message: kXR_close (handle: 0x00000000) ) with status: [SUCCESS] .
[2024-09-19 22:27:30.237256 +0100][Debug ][File ][ 1283] [0x9be6b60@root://bohr3226.tier2.hep.manchester.ac.uk:1094//dune/RSE/justin-tutorial/09/9c/tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712.hdf5?xrdcl.requuid=282e9f23-7bd9-43f9-b722-4f0785593a72] Close returned from se81.in.tier2.hep.manchester.ac.uk:1095 with: [SUCCESS]
[2024-09-19 22:27:30.237295 +0100][Debug ][ExDbgMsg ][ 1283] [se81.in.tier2.hep.manchester.ac.uk:1095] Destroying MsgHandler: 0x10b5e720.
DataPrepByApaModule::endJob: # events processed: 1
DataPrepByApaModule::endJob: # events skipped: 0
===========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
===========================================================================================================================================
Full event 40.2381 40.2381 40.2381 40.2381 0 1
-------------------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput(read) 0.000192798 0.000192798 0.000192798 0.000192798 0 1
produce:caldata:DataPrepByApaModule 27.5828 27.5828 27.5828 27.5828 0 1
produce:rns:RandomNumberSaver 0.000133182 0.000133182 0.000133182 0.000133182 0 1
produce:wclsdatanfsp:WireCellToolkit 12.138 12.138 12.138 12.138 0 1
produce:gaushit:GausHitFinder 0.0274014 0.0274014 0.0274014 0.0274014 0 1
produce:pandora:StandardPandora 0.0938709 0.0938709 0.0938709 0.0938709 0 1
produce:pandoraTrack:LArPandoraTrackCreation 0.00234053 0.00234053 0.00234053 0.00234053 0 1
produce:pandoraShower:LArPandoraModularShowerCreation 0.00106231 0.00106231 0.00106231 0.00106231 0 1
produce:pandoraStdCalo:Calorimetry 0.00171657 0.00171657 0.00171657 0.00171657 0 1
produce:pandoraGnoCalo:GnocchiCalorimetry 0.000599104 0.000599104 0.000599104 0.000599104 0 1
produce:pandorapid:Chi2ParticleID 0.000239328 0.000239328 0.000239328 0.000239328 0 1
[art]:TriggerResults:TriggerResultInserter 3.1291e-05 3.1291e-05 3.1291e-05 3.1291e-05 0 1
end_path:rootout:RootOutput 1.1272e-05 1.1272e-05 1.1272e-05 1.1272e-05 0 1
end_path:rootout:RootOutput(write) 0.387897 0.387897 0.387897 0.387897 0 1
===========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 2988.98 MB
Peak resident set size usage (VmHWM): 1772.74 MB
Details saved in: 'mem.db'
====================================================================================================
PandoraMonitoring, only able to use default TApplication (limited functionality).
PandoraMonitoring::SaveTree, error: No tree with name 'Validation' exists.
ToolBasedRawDigitPrepService:dtor: Event count: 1
ToolBasedRawDigitPrepService:dtor: Call count: 1
ToolBasedRawDigitPrepService:dtor: Time report for 7 tools.
ToolBasedRawDigitPrepService:dtor: digitReader :0.01 sec/event
ToolBasedRawDigitPrepService:dtor: vdcb_adcChannelRawRmsFiller :0.05 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller :0.01 sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_adcScaleAdcToKe :0.11 sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_cnrw :0.02 sec/event
ToolBasedRawDigitPrepService:dtor: adcKeepAllSignalFinder :0.01 sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_adcScaleKeToAdc :0.00 sec/event
Art has completed and will exit with status 0.
[2024-09-19 22:27:31.386907 +0100][Debug ][JobMgr ][ 1283] Stopping the job manager...
[2024-09-19 22:27:31.387501 +0100][Debug ][JobMgr ][ 1283] Job manager stopped
[2024-09-19 22:27:31.387559 +0100][Debug ][TaskMgr ][ 1283] Stopping the task manager...
[2024-09-19 22:27:31.387833 +0100][Debug ][TaskMgr ][ 1283] Task manager stopped
[2024-09-19 22:27:31.387839 +0100][Debug ][Poller ][ 1283] Stopping the poller...
[2024-09-19 22:27:31.387966 +0100][Debug ][TaskMgr ][ 1283] Requesting unregistration of: "TickGeneratorTask for: root://bohr3226.tier2.hep.manchester.ac.uk:1094"
[2024-09-19 22:27:31.388044 +0100][Debug ][AsyncSock ][ 1283] [bohr3226.tier2.hep.manchester.ac.uk:1094.0] Closing the socket
[2024-09-19 22:27:31.388101 +0100][Debug ][Poller ][ 1283] <[::ffff:192.41.104.55]:60830><--><[::ffff:195.194.105.167]:1094> Removing socket from the poller
[2024-09-19 22:27:31.388188 +0100][Debug ][PostMaster ][ 1283] [bohr3226.tier2.hep.manchester.ac.uk:1094] Destroying stream
[2024-09-19 22:27:31.388254 +0100][Debug ][AsyncSock ][ 1283] [bohr3226.tier2.hep.manchester.ac.uk:1094.0] Closing the socket
[2024-09-19 22:27:31.388351 +0100][Debug ][TaskMgr ][ 1283] Requesting unregistration of: "TickGeneratorTask for: root://se81.in.tier2.hep.manchester.ac.uk:1095"
[2024-09-19 22:27:31.388362 +0100][Debug ][AsyncSock ][ 1283] [se81.in.tier2.hep.manchester.ac.uk:1095.0] Closing the socket
[2024-09-19 22:27:31.388500 +0100][Debug ][Poller ][ 1283] <[::ffff:192.41.104.55]:52026><--><[::ffff:195.194.108.180]:1095> Removing socket from the poller
[2024-09-19 22:27:31.388673 +0100][Debug ][PostMaster ][ 1283] [se81.in.tier2.hep.manchester.ac.uk:1095] Destroying stream
[2024-09-19 22:27:31.388681 +0100][Debug ][AsyncSock ][ 1283] [se81.in.tier2.hep.manchester.ac.uk:1095.0] Closing the socket
=== 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.w3310s1",
"art.file_format_era": "ART_2011a",
"art.file_format_version": 15,
"art.first_event": 8856,
"art.last_event": 8856,
"art.process_name": "VDBDEDataPrepReco",
"art.run_type": "vd-coldbox-bottom",
"core.application": "art.reco",
"core.application.family": "art",
"core.application.name": "reco",
"core.application.version": "v09_75_00d00",
"core.data_stream": "test",
"core.data_tier": "full-reconstructed",
"core.end_time": 1726781249.0,
"core.event_count": 1,
"core.file_format": "artroot",
"core.file_type": "detector",
"core.first_event_number": 8856,
"core.last_event_number": 8856,
"core.run_type": "vd-coldbox-bottom",
"core.runs": [
12352
],
"core.runs_subruns": [
1235200001
],
"core.start_time": 1726781246.0
},
"parents": [
{
"did": "justin-tutorial:tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712.hdf5"
}
]
}
===================
.:
total 11204
-rw-r--r-- 1 gl05pi6 eddie_users 10817356 Sep 19 22:27 tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712_reco_data_2024-09-19T_212418Z.root
-rw-r--r-- 1 gl05pi6 eddie_users 435124 Sep 19 22:27 tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712_reco_2024-09-19T_212418Z.log
-rw-r--r-- 1 gl05pi6 eddie_users 116771 Sep 19 22:27 Pandora_Events.pndr
-rw-r--r-- 1 gl05pi6 eddie_users 40960 Sep 19 22:27 mem.db
-rw-r--r-- 1 gl05pi6 eddie_users 16384 Sep 19 22:27 time.db
-rw-r--r-- 1 gl05pi6 eddie_users 12087 Sep 19 22:27 jobscript.log
-rw-r--r-- 1 gl05pi6 eddie_users 1158 Sep 19 22:27 tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712_reco_data_2024-09-19T_212418Z.root.json
-rw-r--r-- 1 gl05pi6 eddie_users 952 Sep 19 22:27 tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712_reco_data_2024-09-19T_212418Z.root.ext.json
-rw-r--r-- 1 gl05pi6 eddie_users 519 Sep 19 22:27 tut_np02bde_307160012_np02_bde_coldbox_run012352_0055_20211216T000712_reco_hist.root
-rw-r--r-- 1 gl05pi6 eddie_users 182 Sep 19 22:24 all-input-dids.txt
-rw-r--r-- 1 gl05pi6 eddie_users 155 Sep 19 22:27 justin-processed-pfns.txt
-rw-r--r-- 1 gl05pi6 eddie_users 0 Sep 19 22:25 debugprod.log 