Jobsub ID 358240.110@justin-prod-sched01.dune.hep.ac.uk
Jobsub ID | 358240.110@justin-prod-sched01.dune.hep.ac.uk |
Workflow ID | 5767 |
Stage ID | 1 |
User name | calcuttj@fnal.gov |
HTCondor Group | group_dune |
Requested | Processors | 1 |
GPU | No |
RSS bytes | 2096103424 (1999 MiB) |
Wall seconds limit | 80000 (22 hours) |
Submitted time | 2025-03-27 17:16:50 |
Site | UK_Edinburgh |
Entry | DUNE_UK_SGridECDF_ce1 |
Last heartbeat | 2025-03-27 17:31:38 |
From worker node | Hostname | node2b01.ecdf.ed.ac.uk |
cpuinfo | Intel(R) Xeon(R) Gold 6338 CPU @ 2.00GHz |
OS release | Scientific Linux release 7.9 (Nitrogen) |
Processors | 1 |
RSS bytes | 2096103424 (1999 MiB) |
Wall seconds limit | 171000 (47 hours) |
GPU | |
Inner Apptainer? | True |
Job state | jobscript_error |
Allocator name | justin-allocator-pro.dune.hep.ac.uk |
Started | 2025-03-27 17:31:16 |
Input files | hd-protodune:np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5
|
Jobscript | Exit code | 1 |
Real time | 0m (0s) |
CPU time | 0m (0s = 0%) |
Max RSS bytes | 0 (0 MiB) |
Outputting started | |
Output files | |
Finished | 2025-03-27 17:31:38 |
Saved logs | justin-logs:358240.110-justin-prod-sched01.dune.hep.ac.uk.logs.tgz |
List job events Wrapper job log |
Jobscript log (last 10,000 characters)
5.5.5, dual-stack: false, private IPv4: false, private IPv6: false
[2025-03-27 17:31:21.857144 +0000][Debug ][AsyncSock ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] TLS hand-shake exchange.
[2025-03-27 17:31:21.864203 +0000][Debug ][AsyncSock ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] TLS hand-shake exchange.
[2025-03-27 17:31:21.869472 +0000][Debug ][AsyncSock ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] TLS hand-shake exchange.
[2025-03-27 17:31:21.869582 +0000][Info ][AsyncSock ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] TLS hand-shake done.
[2025-03-27 17:31:21.873720 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Logged in, session: cb6d0000f9630e002d00000018f70000
[2025-03-27 17:31:21.873730 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Authentication is required: &P=ztn,0:4096:&P=gsi,v:10600,c:ssl,ca:530f7122.0|ffc3d59b.0
[2025-03-27 17:31:21.873740 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Sending authentication data
[2025-03-27 17:31:21.876547 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Trying to authenticate using ztn
[2025-03-27 17:31:21.876583 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Cannot get credentials for protocol ztn: Secztn: No token found; runtime fetch disallowed.
[2025-03-27 17:31:21.880460 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Trying to authenticate using gsi
[2025-03-27 17:31:22.331501 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Sending more authentication data for gsi
[2025-03-27 17:31:22.411565 +0000][Debug ][XRootDTransport ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Authenticated with gsi.
[2025-03-27 17:31:22.411638 +0000][Debug ][PostMaster ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094] Stream 0 connected (IPv4).
[2025-03-27 17:31:22.411656 +0000][Debug ][Utility ][ 1175] Monitor library name not set. No monitoring
[2025-03-27 17:31:22.411764 +0000][Debug ][ExDbgMsg ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094] Moving MsgHandler: 0x3eaff70 (message: kXR_open (file: /cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) from out-queu to in-queue.
[2025-03-27 17:31:22.415576 +0000][Debug ][ExDbgMsg ][ 1175] [msg: 0x3ef6320] Assigned MsgHandler: 0x3eaff70.
[2025-03-27 17:31:22.415584 +0000][Debug ][ExDbgMsg ][ 1175] [handler: 0x3eaff70] Removed MsgHandler: 0x3eaff70 from the in-queue.
[2025-03-27 17:31:22.415675 +0000][Debug ][XRootD ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094] Handling error while processing kXR_open (file: /cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ): [ERROR] Error response: permission denied.
[2025-03-27 17:31:22.415720 +0000][Debug ][ExDbgMsg ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094] Calling MsgHandler: 0x3eaff70 (message: kXR_open (file: /cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5, mode: 00, flags: kXR_open_read kXR_async kXR_retstat ) ) with status: [ERROR] Error response: permission denied.
[2025-03-27 17:31:22.415814 +0000][Debug ][File ][ 1175] [0x3eaaac0@root://cephc02.gla.scotgrid.ac.uk:1094//cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5?xrdcl.requuid=77bc0fd7-c868-44bb-af51-c5ef4995aa2c] Open has returned with status [ERROR] Server responded with an error: [3010] Unable to open /cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5; permission denied
[2025-03-27 17:31:22.415829 +0000][Debug ][File ][ 1175] [0x3eaaac0@root://cephc02.gla.scotgrid.ac.uk:1094//cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5?xrdcl.requuid=77bc0fd7-c868-44bb-af51-c5ef4995aa2c] Error while opening at cephc02.gla.scotgrid.ac.uk:1094: [ERROR] Server responded with an error: [3010] Unable to open /cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5; permission denied
[2025-03-27 17:31:22.415865 +0000][Debug ][ExDbgMsg ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094] Destroying MsgHandler: 0x3eaff70.
HDF5-DIAG: Error detected in HDF5 (1.12.2) thread 0:
#000: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5F.c line 620 in H5Fopen(): unable to open file
major: File accessibility
minor: Unable to open file
#001: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5VLcallback.c line 3501 in H5VL_file_open(): failed to iterate over available VOL connector plugins
major: Virtual Object Layer
minor: Iteration failed
#002: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5PLpath.c line 578 in H5PL__path_table_iterate(): can't iterate over plugins in plugin path '(null)'
major: Plugin for dynamically loaded library
minor: Iteration failed
#003: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5PLpath.c line 620 in H5PL__path_table_iterate_process_path(): can't open directory: /usr/local/hdf5/lib/plugin
major: Plugin for dynamically loaded library
minor: Can't open directory or file
#004: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5VLcallback.c line 3351 in H5VL__file_open(): open failed
major: Virtual Object Layer
minor: Can't open object
#005: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5VLnative_file.c line 97 in H5VL__native_file_open(): unable to open file
major: File accessibility
minor: Unable to open file
#006: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5Fint.c line 1834 in H5F_open(): unable to open file: name = 'root://cephc02.gla.scotgrid.ac.uk:1094//cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5', tent_flags = 0
major: File accessibility
minor: Unable to open file
#007: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5FD.c line 723 in H5FD_open(): open failed
major: Virtual File Layer
minor: Unable to initialize object
#008: /scratch/workspace/build-single/BUILDTYPE/prof/QUAL/e26/label1/swarm/label2/SLF7/build/hdf5/v1_12_2a/source/hdf5-1.12.2/src/H5FDsec2.c line 352 in H5FD__sec2_open(): unable to open file: name = 'root://cephc02.gla.scotgrid.ac.uk:1094//cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5', errno = 13, error message = 'Permission denied', flags = 0, o_flags = 0
major: File accessibility
minor: Unable to open file
====================================================================================================================
TimeTracker printout (sec) Min Avg Max Median RMS nEvts
====================================================================================================================
[ No processed events ]
====================================================================================================================
TrigReport ---------- Event summary -------------
TrigReport Events total = 0 passed = 0 failed = 0
TrigReport ---------- Modules in End-path ----------
TrigReport Run Success Error Name
TrigReport 0 0 0 out1
TimeReport ---------- Time summary [sec] -------
TimeReport CPU = 0.507202 Real = 0.573587
MemReport ---------- Memory summary [base-10 MB] ------
MemReport VmPeak = 965.317 VmHWM = 303.636
%MSG-s ArtException: PostEndJob 27-Mar-2025 17:31:22 GMT ModuleEndJob
---- HDF5RawDataFile BEGIN
File open failure: root://cephc02.gla.scotgrid.ac.uk:1094//cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5 Unable to open file root://cephc02.gla.scotgrid.ac.uk:1094//cephfs/dune/RSE/hd-protodune/db/d0/np04hd_raw_run027410_0128_dataflow3_datawriter_0_20240625T025230.hdf5 (File accessibility) Unable to open file
---- HDF5RawDataFile END
%MSG
Art has completed and will exit with status 1.
[2025-03-27 17:31:22.465665 +0000][Debug ][JobMgr ][ 1175] Stopping the job manager...
[2025-03-27 17:31:22.465937 +0000][Debug ][JobMgr ][ 1175] Job manager stopped
[2025-03-27 17:31:22.465957 +0000][Debug ][TaskMgr ][ 1175] Stopping the task manager...
[2025-03-27 17:31:22.466078 +0000][Debug ][TaskMgr ][ 1175] Task manager stopped
[2025-03-27 17:31:22.466100 +0000][Debug ][Poller ][ 1175] Stopping the poller...
[2025-03-27 17:31:22.466345 +0000][Debug ][AsyncSock ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Closing the socket
[2025-03-27 17:31:22.466393 +0000][Debug ][Poller ][ 1175] <[::ffff:192.41.105.34]:45312><--><[::ffff:130.209.239.113]:1094> Removing socket from the poller
[2025-03-27 17:31:22.466603 +0000][Debug ][PostMaster ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094] Destroying stream
[2025-03-27 17:31:22.466693 +0000][Debug ][AsyncSock ][ 1175] [cephc02.gla.scotgrid.ac.uk:1094.0] Closing the socket