Jobsub ID 259737.0@justin-prod-sched01.dune.hep.ac.uk
| Jobsub ID | 259737.0@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:10 |
| From worker node | Hostname | node2a03.ecdf.ed.ac.uk |
| cpuinfo | Intel(R) Xeon(R) Gold 6130 CPU @ 2.10GHz |
| 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:23:45 |
| Input files | justin-tutorial:tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954.hdf5
|
| Jobscript | Exit code | 0 |
| Real time | 3m (235s) |
| CPU time | 2m (154s = 65%) |
| Outputting started | 2024-09-19 21:27:41 |
| Output files | https://fndcadoor.fnal.gov:2880/dune/scratch/users/dmunoz/03310/1/tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-09-19T_212415Z.root
|
| Finished | 2024-09-19 21:28:10 |
| Saved logs | justin-logs:259737.0-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
| List job events Wrapper job log |
Jobscript log (last 10,000 characters)
024-09-19 22:27:35.123092 +0100][Debug ][ExDbgMsg ][ 1282] [se84.in.tier2.hep.manchester.ac.uk:1095] Moving MsgHandler: 0xb3f8fe0 (message: kXR_close (handle: 0x00000000) ) from out-queu to in-queue.
[2024-09-19 22:27:35.130006 +0100][Debug ][ExDbgMsg ][ 1282] [msg: 0xb3a18c0] Assigned MsgHandler: 0xb3f8fe0.
[2024-09-19 22:27:35.130043 +0100][Debug ][ExDbgMsg ][ 1282] [handler: 0xb3f8fe0] Removed MsgHandler: 0xb3f8fe0 from the in-queue.
[2024-09-19 22:27:35.130207 +0100][Debug ][ExDbgMsg ][ 1282] [se84.in.tier2.hep.manchester.ac.uk:1095] Calling MsgHandler: 0xb3f8fe0 (message: kXR_close (handle: 0x00000000) ) with status: [SUCCESS] .
[2024-09-19 22:27:35.130293 +0100][Debug ][File ][ 1282] [0x9944d10@root://bohr3226.tier2.hep.manchester.ac.uk:1094//dune/RSE/justin-tutorial/23/c3/tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954.hdf5?xrdcl.requuid=9718d839-e88a-4136-b0fa-f17e25ab86d6] Close returned from se84.in.tier2.hep.manchester.ac.uk:1095 with: [SUCCESS]
[2024-09-19 22:27:35.130347 +0100][Debug ][ExDbgMsg ][ 1282] [se84.in.tier2.hep.manchester.ac.uk:1095] Destroying MsgHandler: 0xb3f8fe0.
DataPrepByApaModule::endJob: # events processed: 1
DataPrepByApaModule::endJob: # events skipped: 0
===========================================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
===========================================================================================================================================
Full event 38.9774 38.9774 38.9774 38.9774 0 1
-------------------------------------------------------------------------------------------------------------------------------------------
source:HDF5RawInput(read) 0.000201366 0.000201366 0.000201366 0.000201366 0 1
produce:caldata:DataPrepByApaModule 25.0844 25.0844 25.0844 25.0844 0 1
produce:rns:RandomNumberSaver 0.000144756 0.000144756 0.000144756 0.000144756 0 1
produce:wclsdatanfsp:WireCellToolkit 13.29 13.29 13.29 13.29 0 1
produce:gaushit:GausHitFinder 0.0160348 0.0160348 0.0160348 0.0160348 0 1
produce:pandora:StandardPandora 0.0918813 0.0918813 0.0918813 0.0918813 0 1
produce:pandoraTrack:LArPandoraTrackCreation 0.00322985 0.00322985 0.00322985 0.00322985 0 1
produce:pandoraShower:LArPandoraModularShowerCreation 0.0013965 0.0013965 0.0013965 0.0013965 0 1
produce:pandoraStdCalo:Calorimetry 0.00219702 0.00219702 0.00219702 0.00219702 0 1
produce:pandoraGnoCalo:GnocchiCalorimetry 0.00080619 0.00080619 0.00080619 0.00080619 0 1
produce:pandorapid:Chi2ParticleID 0.000306241 0.000306241 0.000306241 0.000306241 0 1
[art]:TriggerResults:TriggerResultInserter 3.8695e-05 3.8695e-05 3.8695e-05 3.8695e-05 0 1
end_path:rootout:RootOutput 1.4309e-05 1.4309e-05 1.4309e-05 1.4309e-05 0 1
end_path:rootout:RootOutput(write) 0.484648 0.484648 0.484648 0.484648 0 1
===========================================================================================================================================
====================================================================================================
MemoryTracker summary (base-10 MB units used)
Peak virtual memory usage (VmPeak) : 3008.89 MB
Peak resident set size usage (VmHWM): 1805.16 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.02 sec/event
ToolBasedRawDigitPrepService:dtor: vdcb_adcChannelRawRmsFiller :0.07 sec/event
ToolBasedRawDigitPrepService:dtor: adcSampleFiller :0.01 sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_adcScaleAdcToKe :0.14 sec/event
ToolBasedRawDigitPrepService:dtor: vdbcb_cnrw :0.03 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:35.947562 +0100][Debug ][JobMgr ][ 1282] Stopping the job manager...
[2024-09-19 22:27:35.948182 +0100][Debug ][JobMgr ][ 1282] Job manager stopped
[2024-09-19 22:27:35.948293 +0100][Debug ][TaskMgr ][ 1282] Stopping the task manager...
[2024-09-19 22:27:35.948682 +0100][Debug ][TaskMgr ][ 1282] Task manager stopped
[2024-09-19 22:27:35.948694 +0100][Debug ][Poller ][ 1282] Stopping the poller...
[2024-09-19 22:27:35.948866 +0100][Debug ][TaskMgr ][ 1282] Requesting unregistration of: "TickGeneratorTask for: root://bohr3226.tier2.hep.manchester.ac.uk:1094"
[2024-09-19 22:27:35.948911 +0100][Debug ][AsyncSock ][ 1282] [bohr3226.tier2.hep.manchester.ac.uk:1094.0] Closing the socket
[2024-09-19 22:27:35.949024 +0100][Debug ][Poller ][ 1282] <[::ffff:192.41.105.4]:33806><--><[::ffff:195.194.105.167]:1094> Removing socket from the poller
[2024-09-19 22:27:35.949186 +0100][Debug ][PostMaster ][ 1282] [bohr3226.tier2.hep.manchester.ac.uk:1094] Destroying stream
[2024-09-19 22:27:35.949271 +0100][Debug ][AsyncSock ][ 1282] [bohr3226.tier2.hep.manchester.ac.uk:1094.0] Closing the socket
[2024-09-19 22:27:35.949330 +0100][Debug ][TaskMgr ][ 1282] Requesting unregistration of: "TickGeneratorTask for: root://se84.in.tier2.hep.manchester.ac.uk:1095"
[2024-09-19 22:27:35.949344 +0100][Debug ][AsyncSock ][ 1282] [se84.in.tier2.hep.manchester.ac.uk:1095.0] Closing the socket
[2024-09-19 22:27:35.949428 +0100][Debug ][Poller ][ 1282] <[::ffff:192.41.105.4]:51604><--><[::ffff:195.194.107.182]:1095> Removing socket from the poller
[2024-09-19 22:27:35.949486 +0100][Debug ][PostMaster ][ 1282] [se84.in.tier2.hep.manchester.ac.uk:1095] Destroying stream
[2024-09-19 22:27:35.949698 +0100][Debug ][AsyncSock ][ 1282] [se84.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": 9017,
"art.last_event": 9017,
"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": 1726781254.0,
"core.event_count": 1,
"core.file_format": "artroot",
"core.file_type": "detector",
"core.first_event_number": 9017,
"core.last_event_number": 9017,
"core.run_type": "vd-coldbox-bottom",
"core.runs": [
12352
],
"core.runs_subruns": [
1235200001
],
"core.start_time": 1726781251.0
},
"parents": [
{
"did": "justin-tutorial:tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954.hdf5"
}
]
}
===================
.:
total 11076
-rw-r--r-- 1 gl05pi6 eddie_users 10730341 Sep 19 22:27 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-09-19T_212415Z.root
-rw-r--r-- 1 gl05pi6 eddie_users 428011 Sep 19 22:27 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_2024-09-19T_212415Z.log
-rw-r--r-- 1 gl05pi6 eddie_users 78125 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 12078 Sep 19 22:27 jobscript.log
-rw-r--r-- 1 gl05pi6 eddie_users 1158 Sep 19 22:27 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-09-19T_212415Z.root.json
-rw-r--r-- 1 gl05pi6 eddie_users 952 Sep 19 22:27 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_data_2024-09-19T_212415Z.root.ext.json
-rw-r--r-- 1 gl05pi6 eddie_users 519 Sep 19 22:27 tut_np02bde_307160116_np02_bde_coldbox_run012352_0056_20211216T000954_reco_hist.root
-rw-r--r-- 1 gl05pi6 eddie_users 182 Sep 19 22:23 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 