+ PROC_LSST_SUBMIT_PATH=/mmfs1/home/stevengs/dirac/DEEP/submit + bps submit /gscratch/dirac/shared/opt/proc_lsst/pipelines/submit.yaml -b /mmfs1/home/stevengs/dirac/DEEP/repo -i DEEP/20190829/B1c --output-run DEEP/20190829/B1c/science#step1/20240313T083341Z --qgraph pipeline.qgraph lsst.ctrl.bps.drivers INFO: DISCLAIMER: All values regarding memory consumption reported below are approximate and may not accurately reflect actual memory usage by the bps process. lsst.ctrl.bps.drivers INFO: Starting submission process lsst.ctrl.bps.drivers INFO: Initializing execution environment lsst.ctrl.bps.drivers INFO: Initializing execution environment completed: Took 1.0804 seconds; current memory usage: 0.181 Gibyte, delta: 0.044 Gibyte, peak delta: 0.054 Gibyte lsst.ctrl.bps.drivers INFO: Peak memory usage for bps process 0.191 Gibyte (main), 0.000 Gibyte (largest child process) lsst.ctrl.bps.drivers INFO: Starting acquire stage (generating and/or reading quantum graph) lsst.ctrl.bps.pre_transform INFO: Copying quantum graph from 'pipeline.qgraph' lsst.ctrl.bps.pre_transform INFO: Completed copying quantum graph: Took 0.0038 seconds lsst.ctrl.bps.pre_transform INFO: Backing up quantum graph from '/mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/pipeline.qgraph' lsst.ctrl.bps.pre_transform INFO: Completed backing up quantum graph: Took 0.0087 seconds lsst.ctrl.bps.pre_transform INFO: /mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/share/eups/Linux64/ctrl_mpexec/g1ce94f1343+c79f27626b/bin/pipetask --long-log --log-level=VERBOSE update-graph-run /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/pipeline_orig.qgraph DEEP/20190829/B1c/science#step1/20240313T083341Z /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/pipeline.qgraph lsst.ctrl.bps.pre_transform INFO: Reading quantum graph from '/mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/pipeline.qgraph' lsst.ctrl.bps.pre_transform INFO: Completed reading quantum graph: Took 4.0601 seconds lsst.ctrl.bps.drivers INFO: Acquire stage completed: Took 9.4808 seconds; current memory usage: 0.337 Gibyte, delta: 0.156 Gibyte, peak delta: 0.146 Gibyte lsst.ctrl.bps.drivers INFO: Peak memory usage for bps process 0.337 Gibyte (main), 0.328 Gibyte (largest child process) lsst.ctrl.bps.drivers INFO: Starting cluster stage (grouping quanta into jobs) lsst.ctrl.bps.drivers INFO: Cluster stage completed: Took 0.0079 seconds; current memory usage: 0.337 Gibyte, delta: 0.000 Gibyte, peak delta: 0.000 Gibyte lsst.ctrl.bps.drivers INFO: Peak memory usage for bps process 0.337 Gibyte (main), 0.328 Gibyte (largest child process) lsst.ctrl.bps.drivers INFO: ClusteredQuantumGraph contains 18 cluster(s) lsst.ctrl.bps.drivers INFO: Starting transform stage (creating generic workflow) lsst.ctrl.bps.drivers INFO: Generic workflow name 'DEEP_20190829_B1c_science#step1_20240313T083341Z' lsst.ctrl.bps.drivers INFO: Transform stage completed: Took 0.0231 seconds; current memory usage: 0.337 Gibyte, delta: 0.000 Gibyte, peak delta: 0.000 Gibyte lsst.ctrl.bps.drivers INFO: Peak memory usage for bps process 0.337 Gibyte (main), 0.328 Gibyte (largest child process) lsst.ctrl.bps.drivers INFO: GenericWorkflow contains 20 job(s) (including final) lsst.ctrl.bps.drivers INFO: Starting prepare stage (creating specific implementation of workflow) parsl.addresses ERROR: Ignoring failure to fetch address from interface eno2 Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/addresses.py", line 111, in get_all_addresses s_addresses.add(address_by_interface(interface)) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/typeguard/__init__.py", line 1033, in wrapper retval = func(*args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/addresses.py", line 93, in address_by_interface return socket.inet_ntoa(fcntl.ioctl( ^^^^^^^^^^^^ OSError: [Errno 99] Cannot assign requested address lsst.ctrl.bps.parsl INFO: Writing workflow with ID=/mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z lsst.ctrl.bps.drivers INFO: Prepare stage completed: Took 0.1147 seconds; current memory usage: 0.338 Gibyte, delta: 0.001 Gibyte, peak delta: 0.001 Gibyte lsst.ctrl.bps.drivers INFO: Peak memory usage for bps process 0.338 Gibyte (main), 0.328 Gibyte (largest child process) lsst.ctrl.bps.drivers INFO: Starting submit stage lsst.ctrl.bps.submit INFO: Submitting run to a workflow management system for execution parsl.dataflow.rundirs DEBUG: Parsl run initializing in rundir: runinfo/000 parsl.dataflow.dflow INFO: Starting DataFlowKernel with config Config( app_cache=True, checkpoint_files=None, checkpoint_mode='task_exit', checkpoint_period=None, executors=[MultiHighThroughputExecutor()], garbage_collect=True, initialize_logging=True, internal_tasks_max_threads=10, max_idletime=120.0, monitoring=None, retries=1, retry_handler=None, run_dir='runinfo', strategy='simple', usage_tracking=False ) parsl.dataflow.dflow INFO: Parsl version: 2023.06.12 parsl.usage_tracking.usage DEBUG: Tracking status: False parsl.dataflow.dflow INFO: Run id is: 2fb9bf0d-313c-4668-a1e2-3bae06e47d8e parsl.dataflow.dflow DEBUG: Considering candidate for workflow name: /mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py parsl.dataflow.dflow DEBUG: Considering candidate for workflow name: /mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/typeguard/__init__.py parsl.dataflow.dflow DEBUG: Considering candidate for workflow name: /mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py parsl.dataflow.dflow DEBUG: Considering candidate for workflow name: /mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/typeguard/__init__.py parsl.dataflow.dflow DEBUG: Considering candidate for workflow name: /mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/share/eups/Linux64/ctrl_bps_parsl/g145af14111+5b908e21bc/python/lsst/ctrl/bps/parsl/workflow.py parsl.dataflow.dflow DEBUG: Using workflow.py as workflow name parsl.dataflow.memoization INFO: App caching initialized parsl.dataflow.strategy DEBUG: Scaling strategy: simple parsl.executors.high_throughput.executor DEBUG: Starting queue management thread parsl.executors.high_throughput.executor DEBUG: queue management worker starting parsl.executors.high_throughput.executor DEBUG: Started queue management thread Submit dir: /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z parsl.executors.high_throughput.executor DEBUG: Created management thread: parsl.executors.high_throughput.executor DEBUG: Launch command: process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id={block_id} --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn parsl.executors.high_throughput.executor DEBUG: Starting HighThroughputExecutor with provider: parsl.executors.status_handling INFO: Scaling out by 1 blocks parsl.executors.status_handling INFO: Allocated block ID 0 parsl.executors.status_handling DEBUG: Submitting to provider with job_name parsl.multi.block-0 2024-03-13 08:34:08 proc_lsst.multi:153 [INFO] [multi] got submit process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=0 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 1 parsl.multi.block-0 proc_lsst.multi INFO: [multi] got submit process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=0 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 1 parsl.multi.block-0 2024-03-13 08:34:08 proc_lsst.multi:162 [INFO] [multi] local process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=0 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 proc_lsst.multi INFO: [multi] local process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=0 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 2024-03-13 08:34:08 proc_lsst.multi:163 [INFO] [multi] len(self.providers[provider].resources) 0 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 0 2024-03-13 08:34:08 proc_lsst.multi:164 [INFO] [multi] self.providers[provider].max_blocks 1 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 1 2024-03-13 08:34:08 proc_lsst.multi:166 [INFO] [multi] submitting process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=0 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 to local proc_lsst.multi INFO: [multi] submitting process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=0 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 to local parsl.providers.local.local DEBUG: Launching in remote mode 2024-03-13 08:34:08 proc_lsst.multi:170 [INFO] [multi] job_id 26708 proc_lsst.multi INFO: [multi] job_id 26708 2024-03-13 08:34:08 proc_lsst.multi:171 [INFO] [multi] len(self.providers[provider].resources) 1 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 1 2024-03-13 08:34:08 proc_lsst.multi:172 [INFO] [multi] self.providers[provider].max_blocks 1 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 1 2024-03-13 08:34:08 proc_lsst.multi:178 [INFO] [multi] provider local accepted submit and returned 26708 proc_lsst.multi INFO: [multi] provider local accepted submit and returned 26708 parsl.executors.status_handling DEBUG: Launched block 0 on executor multi with job ID 26708 parsl.dataflow.job_status_poller DEBUG: Adding executor multi parsl.dataflow.dflow DEBUG: Task 0 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 0 submitted for App calibrate, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 0 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 0 has memoization hash f4bbd5c434b097e8cfff9ea0316e3f82 parsl.dataflow.memoization INFO: Task 0 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb060> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 0 try 0 launched on executor multi with executor id 1 parsl.dataflow.dflow INFO: Standard output for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stdout parsl.dataflow.dflow INFO: Standard error for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stderr parsl.dataflow.dflow DEBUG: Task 1 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 1 submitted for App calibrate, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 1 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 1 has memoization hash 7d65a70d3ad7b2eacead05e231711ee2 parsl.dataflow.memoization INFO: Task 1 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb420> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 1 try 0 launched on executor multi with executor id 2 parsl.dataflow.dflow INFO: Standard output for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stdout parsl.dataflow.dflow INFO: Standard error for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stderr parsl.dataflow.dflow DEBUG: Task 2 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 2 submitted for App calibrate, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 2 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 2 has memoization hash 2fb36e3264a6d49950f9b9e4cacfb16f parsl.dataflow.memoization INFO: Task 2 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb6a0> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 2 try 0 launched on executor multi with executor id 3 parsl.dataflow.dflow INFO: Standard output for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stdout parsl.dataflow.dflow INFO: Standard error for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stderr parsl.dataflow.dflow DEBUG: Task 3 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 3 submitted for App calibrate, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 3 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 3 has memoization hash ee452db849529c5ee424e053317bcecb parsl.dataflow.memoization INFO: Task 3 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb560> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 3 try 0 launched on executor multi with executor id 4 parsl.dataflow.dflow INFO: Standard output for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stdout parsl.dataflow.dflow INFO: Standard error for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stderr parsl.dataflow.dflow DEBUG: Task 4 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 4 submitted for App calibrate, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 4 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 4 has memoization hash b9feccde80c897279b6a31da655f1233 parsl.dataflow.memoization INFO: Task 4 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb600> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 4 try 0 launched on executor multi with executor id 5 parsl.dataflow.dflow INFO: Standard output for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stdout parsl.dataflow.dflow INFO: Standard error for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stderr parsl.dataflow.dflow DEBUG: Task 5 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 5 submitted for App calibrate, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 5 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 5 has memoization hash 2e4bd8f79106822b2a2d3ccc27ffc210 parsl.dataflow.memoization INFO: Task 5 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb880> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 5 try 0 launched on executor multi with executor id 6 parsl.dataflow.dflow INFO: Standard output for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stdout parsl.dataflow.dflow INFO: Standard error for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stderr parsl.dataflow.dflow DEBUG: Task 6 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 6 submitted for App characterizeImage, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 6 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 6 has memoization hash 2aefd4ffe821b8baedf4ed440eea07fa parsl.dataflow.memoization INFO: Task 6 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb1a0> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 6 try 0 launched on executor multi with executor id 7 parsl.dataflow.dflow INFO: Standard output for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stdout parsl.dataflow.dflow INFO: Standard error for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stderr parsl.dataflow.dflow DEBUG: Task 7 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 7 submitted for App calibrate, waiting on task 6 parsl.dataflow.dflow DEBUG: Task 7 set to pending state with AppFuture: parsl.dataflow.dflow DEBUG: Task 7 has outstanding dependencies, so launch_if_ready skipping parsl.dataflow.dflow DEBUG: Task 8 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 8 submitted for App characterizeImage, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 8 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 8 has memoization hash 243e321ab1ba03a99e83624ef20ad10b parsl.dataflow.memoization INFO: Task 8 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb240> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 8 try 0 launched on executor multi with executor id 8 parsl.dataflow.dflow INFO: Standard output for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stdout parsl.dataflow.dflow INFO: Standard error for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stderr parsl.dataflow.dflow DEBUG: Task 9 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 9 submitted for App calibrate, waiting on task 8 parsl.dataflow.dflow DEBUG: Task 9 set to pending state with AppFuture: parsl.dataflow.dflow DEBUG: Task 9 has outstanding dependencies, so launch_if_ready skipping parsl.dataflow.dflow DEBUG: Task 10 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 10 submitted for App characterizeImage, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 10 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 10 has memoization hash ca99ffebc54cad6e263a0450cde5adad parsl.dataflow.memoization INFO: Task 10 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb920> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 10 try 0 launched on executor multi with executor id 9 parsl.dataflow.dflow INFO: Standard output for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stdout parsl.dataflow.dflow INFO: Standard error for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stderr parsl.dataflow.dflow DEBUG: Task 11 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 11 submitted for App calibrate, waiting on task 10 parsl.dataflow.dflow DEBUG: Task 11 set to pending state with AppFuture: parsl.dataflow.dflow DEBUG: Task 11 has outstanding dependencies, so launch_if_ready skipping parsl.dataflow.dflow DEBUG: Task 12 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 12 submitted for App characterizeImage, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 12 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 12 has memoization hash b077ff05c33aadd12dc2dc09dc6cba0c parsl.dataflow.memoization INFO: Task 12 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefbf60> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 12 try 0 launched on executor multi with executor id 10 parsl.dataflow.dflow INFO: Standard output for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stdout parsl.dataflow.dflow INFO: Standard error for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stderr parsl.dataflow.dflow DEBUG: Task 13 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 13 submitted for App calibrate, waiting on task 12 parsl.dataflow.dflow DEBUG: Task 13 set to pending state with AppFuture: parsl.dataflow.dflow DEBUG: Task 13 has outstanding dependencies, so launch_if_ready skipping parsl.dataflow.dflow DEBUG: Task 14 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 14 submitted for App characterizeImage, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 14 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 14 has memoization hash 2fc4d608c66524713652b42a6b52a21d parsl.dataflow.memoization INFO: Task 14 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857d34c2c0> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 14 try 0 launched on executor multi with executor id 11 parsl.dataflow.dflow INFO: Standard output for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stdout parsl.dataflow.dflow INFO: Standard error for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stderr parsl.dataflow.dflow DEBUG: Task 15 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 15 submitted for App calibrate, waiting on task 14 parsl.dataflow.dflow DEBUG: Task 15 set to pending state with AppFuture: parsl.dataflow.dflow DEBUG: Task 15 has outstanding dependencies, so launch_if_ready skipping parsl.dataflow.dflow DEBUG: Task 16 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 16 submitted for App characterizeImage, not waiting on any dependency parsl.dataflow.dflow DEBUG: Task 16 set to pending state with AppFuture: parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 16 has memoization hash 3c7e5607af9b7f3e7b3727f498d831a6 parsl.dataflow.memoization INFO: Task 16 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857d34c180> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 16 try 0 launched on executor multi with executor id 12 parsl.dataflow.dflow INFO: Standard output for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stdout parsl.dataflow.dflow INFO: Standard error for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stderr parsl.dataflow.dflow DEBUG: Task 17 will be sent to executor multi parsl.dataflow.dflow DEBUG: Adding output dependencies parsl.dataflow.dflow INFO: Task 17 submitted for App calibrate, waiting on task 16 parsl.dataflow.dflow DEBUG: Task 17 set to pending state with AppFuture: parsl.dataflow.dflow DEBUG: Task 17 has outstanding dependencies, so launch_if_ready skipping 2024-03-13 08:34:09 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 1, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 1/0 running/pending blocks, and 2 connected workers parsl.dataflow.strategy DEBUG: Strategy case 2: slots are overloaded - (slot_ratio = active_slots/active_tasks) < parallelism parsl.dataflow.strategy DEBUG: Strategy case 2b: active_blocks 1 < max_blocks 312 so scaling out parsl.dataflow.strategy DEBUG: Requesting 2 more blocks parsl.executors.status_handling INFO: Scaling out by 2 blocks parsl.executors.status_handling INFO: Allocated block ID 1 parsl.executors.status_handling DEBUG: Submitting to provider with job_name parsl.multi.block-1 2024-03-13 08:34:09 proc_lsst.multi:153 [INFO] [multi] got submit process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 1 parsl.multi.block-1 proc_lsst.multi INFO: [multi] got submit process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 1 parsl.multi.block-1 2024-03-13 08:34:09 proc_lsst.multi:162 [INFO] [multi] local process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 proc_lsst.multi INFO: [multi] local process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 2024-03-13 08:34:09 proc_lsst.multi:163 [INFO] [multi] len(self.providers[provider].resources) 1 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 1 2024-03-13 08:34:09 proc_lsst.multi:164 [INFO] [multi] self.providers[provider].max_blocks 1 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 1 2024-03-13 08:34:09 proc_lsst.multi:162 [INFO] [multi] astro process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn proc_lsst.multi INFO: [multi] astro process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 2024-03-13 08:34:09 proc_lsst.multi:163 [INFO] [multi] len(self.providers[provider].resources) 0 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 0 2024-03-13 08:34:09 proc_lsst.multi:164 [INFO] [multi] self.providers[provider].max_blocks 30 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 30 2024-03-13 08:34:09 proc_lsst.multi:166 [INFO] [multi] submitting process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn to astro proc_lsst.multi INFO: [multi] submitting process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=1 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn to astro parsl.providers.slurm.slurm DEBUG: Requesting one block with 1 nodes parsl.providers.slurm.slurm DEBUG: Writing submit script parsl.providers.slurm.slurm DEBUG: moving files 2024-03-13 08:34:09 proc_lsst.multi:170 [INFO] [multi] job_id 17008852 proc_lsst.multi INFO: [multi] job_id 17008852 2024-03-13 08:34:09 proc_lsst.multi:171 [INFO] [multi] len(self.providers[provider].resources) 1 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 1 2024-03-13 08:34:09 proc_lsst.multi:172 [INFO] [multi] self.providers[provider].max_blocks 30 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 30 2024-03-13 08:34:09 proc_lsst.multi:178 [INFO] [multi] provider astro accepted submit and returned 17008852 proc_lsst.multi INFO: [multi] provider astro accepted submit and returned 17008852 parsl.executors.status_handling DEBUG: Launched block 1 on executor multi with job ID 17008852 parsl.executors.status_handling INFO: Allocated block ID 2 parsl.executors.status_handling DEBUG: Submitting to provider with job_name parsl.multi.block-2 2024-03-13 08:34:09 proc_lsst.multi:153 [INFO] [multi] got submit process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 1 parsl.multi.block-2 proc_lsst.multi INFO: [multi] got submit process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 1 parsl.multi.block-2 2024-03-13 08:34:09 proc_lsst.multi:162 [INFO] [multi] local process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 proc_lsst.multi INFO: [multi] local process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn --max_workers 2 2024-03-13 08:34:09 proc_lsst.multi:163 [INFO] [multi] len(self.providers[provider].resources) 1 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 1 2024-03-13 08:34:09 proc_lsst.multi:164 [INFO] [multi] self.providers[provider].max_blocks 1 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 1 2024-03-13 08:34:09 proc_lsst.multi:162 [INFO] [multi] astro process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn proc_lsst.multi INFO: [multi] astro process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn 2024-03-13 08:34:09 proc_lsst.multi:163 [INFO] [multi] len(self.providers[provider].resources) 1 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 1 2024-03-13 08:34:09 proc_lsst.multi:164 [INFO] [multi] self.providers[provider].max_blocks 30 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 30 2024-03-13 08:34:09 proc_lsst.multi:166 [INFO] [multi] submitting process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn to astro proc_lsst.multi INFO: [multi] submitting process_worker_pool.py -a 10.64.65.9,10.64.129.9,127.0.0.1,n3009,169.254.95.120,198.48.92.26 -p 0 -c 1.0 -m None --poll 10 --task_port=54464 --result_port=54354 --logdir=/mmfs1/gscratch/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/runinfo/000/multi --block_id=2 --hb_period=30 --hb_threshold=120 --cpu-affinity none --available-accelerators --start-method spawn to astro parsl.providers.slurm.slurm DEBUG: Requesting one block with 1 nodes parsl.providers.slurm.slurm DEBUG: Writing submit script parsl.providers.slurm.slurm DEBUG: moving files 2024-03-13 08:34:10 proc_lsst.multi:170 [INFO] [multi] job_id 17008853 proc_lsst.multi INFO: [multi] job_id 17008853 2024-03-13 08:34:10 proc_lsst.multi:171 [INFO] [multi] len(self.providers[provider].resources) 2 proc_lsst.multi INFO: [multi] len(self.providers[provider].resources) 2 2024-03-13 08:34:10 proc_lsst.multi:172 [INFO] [multi] self.providers[provider].max_blocks 30 proc_lsst.multi INFO: [multi] self.providers[provider].max_blocks 30 2024-03-13 08:34:10 proc_lsst.multi:178 [INFO] [multi] provider astro accepted submit and returned 17008853 proc_lsst.multi INFO: [multi] provider astro accepted submit and returned 17008853 parsl.executors.status_handling DEBUG: Launched block 2 on executor multi with job ID 17008853 parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 1/2 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 1/2 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 1/2 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 1/2 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 1/2 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 2024-03-13 08:34:39 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:34:39 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING 2024-03-13 08:34:40 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 0 try 0 failed parsl.dataflow.dflow INFO: Task 0 marked for retry parsl.dataflow.dflow INFO: Standard output for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stdout parsl.dataflow.dflow INFO: Standard error for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 0 has memoization hash f4bbd5c434b097e8cfff9ea0316e3f82 parsl.dataflow.memoization INFO: Task 0 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb060> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 0 try 1 launched on executor multi with executor id 13 parsl.dataflow.dflow INFO: Standard output for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stdout parsl.dataflow.dflow INFO: Standard error for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stderr parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 1 try 0 failed parsl.dataflow.dflow INFO: Task 1 marked for retry parsl.dataflow.dflow INFO: Standard output for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stdout parsl.dataflow.dflow INFO: Standard error for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 1 has memoization hash 7d65a70d3ad7b2eacead05e231711ee2 parsl.dataflow.memoization INFO: Task 1 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb420> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 1 try 1 launched on executor multi with executor id 14 parsl.dataflow.dflow INFO: Standard output for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stdout parsl.dataflow.dflow INFO: Standard error for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stderr 2024-03-13 08:35:09 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:35:09 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING 2024-03-13 08:35:10 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 2 try 0 failed parsl.dataflow.dflow INFO: Task 2 marked for retry parsl.dataflow.dflow INFO: Standard output for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stdout parsl.dataflow.dflow INFO: Standard error for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 2 has memoization hash 2fb36e3264a6d49950f9b9e4cacfb16f parsl.dataflow.memoization INFO: Task 2 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb6a0> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 2 try 1 launched on executor multi with executor id 15 parsl.dataflow.dflow INFO: Standard output for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stdout parsl.dataflow.dflow INFO: Standard error for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 3 try 0 failed parsl.dataflow.dflow INFO: Task 3 marked for retry parsl.dataflow.dflow INFO: Standard output for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stdout parsl.dataflow.dflow INFO: Standard error for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 3 has memoization hash ee452db849529c5ee424e053317bcecb parsl.dataflow.memoization INFO: Task 3 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb560> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 3 try 1 launched on executor multi with executor id 16 parsl.dataflow.dflow INFO: Standard output for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stdout parsl.dataflow.dflow INFO: Standard error for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stderr parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 6 try 0 failed parsl.dataflow.dflow INFO: Task 6 marked for retry parsl.dataflow.dflow INFO: Standard output for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stdout parsl.dataflow.dflow INFO: Standard error for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 6 has memoization hash 2aefd4ffe821b8baedf4ed440eea07fa parsl.dataflow.memoization INFO: Task 6 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb1a0> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 6 try 1 launched on executor multi with executor id 17 parsl.dataflow.dflow INFO: Standard output for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stdout parsl.dataflow.dflow INFO: Standard error for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 8 try 0 failed parsl.dataflow.dflow INFO: Task 8 marked for retry parsl.dataflow.dflow INFO: Standard output for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stdout parsl.dataflow.dflow INFO: Standard error for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 8 has memoization hash 243e321ab1ba03a99e83624ef20ad10b parsl.dataflow.memoization INFO: Task 8 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb240> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 8 try 1 launched on executor multi with executor id 18 parsl.dataflow.dflow INFO: Standard output for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stdout parsl.dataflow.dflow INFO: Standard error for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stderr parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 10 try 0 failed parsl.dataflow.dflow INFO: Task 10 marked for retry parsl.dataflow.dflow INFO: Standard output for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stdout parsl.dataflow.dflow INFO: Standard error for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 10 has memoization hash ca99ffebc54cad6e263a0450cde5adad parsl.dataflow.memoization INFO: Task 10 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb920> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 10 try 1 launched on executor multi with executor id 19 parsl.dataflow.dflow INFO: Standard output for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stdout parsl.dataflow.dflow INFO: Standard error for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 12 try 0 failed parsl.dataflow.dflow INFO: Task 12 marked for retry parsl.dataflow.dflow INFO: Standard output for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stdout parsl.dataflow.dflow INFO: Standard error for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 12 has memoization hash b077ff05c33aadd12dc2dc09dc6cba0c parsl.dataflow.memoization INFO: Task 12 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefbf60> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 12 try 1 launched on executor multi with executor id 20 parsl.dataflow.dflow INFO: Standard output for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stdout parsl.dataflow.dflow INFO: Standard error for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stderr 2024-03-13 08:35:39 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:35:39 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 14 try 0 failed parsl.dataflow.dflow INFO: Task 14 marked for retry parsl.dataflow.dflow INFO: Standard output for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stdout parsl.dataflow.dflow INFO: Standard error for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 14 has memoization hash 2fc4d608c66524713652b42a6b52a21d parsl.dataflow.memoization INFO: Task 14 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857d34c2c0> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 14 try 1 launched on executor multi with executor id 21 parsl.dataflow.dflow INFO: Standard output for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stdout parsl.dataflow.dflow INFO: Standard error for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stderr parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING 2024-03-13 08:35:40 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 16 try 0 failed parsl.dataflow.dflow INFO: Task 16 marked for retry parsl.dataflow.dflow INFO: Standard output for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stdout parsl.dataflow.dflow INFO: Standard error for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 16 has memoization hash 3c7e5607af9b7f3e7b3727f498d831a6 parsl.dataflow.memoization INFO: Task 16 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857d34c180> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 16 try 1 launched on executor multi with executor id 22 parsl.dataflow.dflow INFO: Standard output for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stdout parsl.dataflow.dflow INFO: Standard error for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 5 try 0 failed parsl.dataflow.dflow INFO: Task 5 marked for retry parsl.dataflow.dflow INFO: Standard output for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stdout parsl.dataflow.dflow INFO: Standard error for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 5 has memoization hash 2e4bd8f79106822b2a2d3ccc27ffc210 parsl.dataflow.memoization INFO: Task 5 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb880> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 5 try 1 launched on executor multi with executor id 23 parsl.dataflow.dflow INFO: Standard output for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stdout parsl.dataflow.dflow INFO: Standard error for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 2024-03-13 08:36:09 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:36:09 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING 2024-03-13 08:36:10 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 4 try 0 failed parsl.dataflow.dflow INFO: Task 4 marked for retry parsl.dataflow.dflow INFO: Standard output for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stdout parsl.dataflow.dflow INFO: Standard error for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stderr parsl.dataflow.memoization DEBUG: Ignoring these kwargs for checkpointing: ['stderr', 'stdout'] parsl.dataflow.memoization DEBUG: Ignoring kwarg stderr parsl.dataflow.memoization DEBUG: Ignoring kwarg stdout parsl.dataflow.memoization DEBUG: Task 4 has memoization hash b9feccde80c897279b6a31da655f1233 parsl.dataflow.memoization INFO: Task 4 had no result in cache parsl.executors.high_throughput.executor DEBUG: Pushing function .wrapper at 0x14857eefb600> to queue with args ("'${CTRL_MPEXEC_DIR}/bin/pipetask --long-log --log-level=VERBOSE run-qbb /mmfs1/home/stevengs/dirac/D...",) parsl.dataflow.dflow INFO: Parsl task 4 try 1 launched on executor multi with executor id 24 parsl.dataflow.dflow INFO: Standard output for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stdout parsl.dataflow.dflow INFO: Standard error for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 12 parsl.dataflow.strategy DEBUG: Executor multi has 12 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 0 try 1 failed parsl.dataflow.dflow ERROR: Task 0 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app calibrate failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry f4bbd5c434b097e8cfff9ea0316e3f82 with result from task 0 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stdout parsl.dataflow.dflow INFO: Standard error for task 0 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/c66bd967-6c64-4fa3-ab02-6e72cf56ced2_calibrate_891942_61.stderr 2024-03-13 08:36:39 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:36:39 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING 2024-03-13 08:36:40 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 11 parsl.dataflow.strategy DEBUG: Executor multi has 11 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 6 try 1 failed parsl.dataflow.dflow ERROR: Task 6 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app characterizeImage failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry 2aefd4ffe821b8baedf4ed440eea07fa with result from task 6 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Task 7 failed due to dependency failure parsl.dataflow.dflow DEBUG: Task 7 try 0 failed parsl.dataflow.dflow INFO: Task 7 failed due to dependency failure so skipping retries parsl.dataflow.memoization ERROR: Attempting to update app cache entry but hashsum is not a string key parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 7 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/81f238f3-510f-478f-92e3-90a1a1f019e5_calibrate_891836_2.stdout parsl.dataflow.dflow INFO: Standard error for task 7 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/81f238f3-510f-478f-92e3-90a1a1f019e5_calibrate_891836_2.stderr parsl.dataflow.dflow INFO: Standard output for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stdout parsl.dataflow.dflow INFO: Standard error for task 6 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891836/ecd820b2-2467-41f3-86d8-1441f8668e0c_characterizeImage_891836_2.stderr parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 1 try 1 failed parsl.dataflow.dflow ERROR: Task 1 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app calibrate failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry 7d65a70d3ad7b2eacead05e231711ee2 with result from task 1 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stdout parsl.dataflow.dflow INFO: Standard error for task 1 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/6e4a2532-3580-4a09-94c0-212f6f65ba5b_calibrate_891944_61.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 9 parsl.dataflow.strategy DEBUG: Executor multi has 9 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 8 try 1 failed parsl.dataflow.dflow ERROR: Task 8 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app characterizeImage failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry 243e321ab1ba03a99e83624ef20ad10b with result from task 8 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Task 9 failed due to dependency failure parsl.dataflow.dflow DEBUG: Task 9 try 0 failed parsl.dataflow.dflow INFO: Task 9 failed due to dependency failure so skipping retries parsl.dataflow.memoization ERROR: Attempting to update app cache entry but hashsum is not a string key parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 9 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/49ba1e83-5d2a-408a-ba89-b2eb802e6b1b_calibrate_891942_2.stdout parsl.dataflow.dflow INFO: Standard error for task 9 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891942/49ba1e83-5d2a-408a-ba89-b2eb802e6b1b_calibrate_891942_2.stderr parsl.dataflow.dflow INFO: Standard output for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stdout parsl.dataflow.dflow INFO: Standard error for task 8 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891942/84cf1add-a6bb-4208-be11-a553ef544580_characterizeImage_891942_2.stderr parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 10 try 1 failed parsl.dataflow.dflow ERROR: Task 10 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app characterizeImage failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry ca99ffebc54cad6e263a0450cde5adad with result from task 10 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Task 11 failed due to dependency failure parsl.dataflow.dflow DEBUG: Task 11 try 0 failed parsl.dataflow.dflow INFO: Task 11 failed due to dependency failure so skipping retries parsl.dataflow.memoization ERROR: Attempting to update app cache entry but hashsum is not a string key parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 11 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/2b790d95-a279-4579-9bd7-110ecf36a4ac_calibrate_891834_2.stdout parsl.dataflow.dflow INFO: Standard error for task 11 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/2b790d95-a279-4579-9bd7-110ecf36a4ac_calibrate_891834_2.stderr parsl.dataflow.dflow INFO: Standard output for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stdout parsl.dataflow.dflow INFO: Standard error for task 10 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891834/5aab6fb0-72bc-4849-b11a-9964aeb667af_characterizeImage_891834_2.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 7 parsl.dataflow.strategy DEBUG: Executor multi has 7 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 12 try 1 failed parsl.dataflow.dflow ERROR: Task 12 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app characterizeImage failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry b077ff05c33aadd12dc2dc09dc6cba0c with result from task 12 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Task 13 failed due to dependency failure parsl.dataflow.dflow DEBUG: Task 13 try 0 failed parsl.dataflow.dflow INFO: Task 13 failed due to dependency failure so skipping retries parsl.dataflow.memoization ERROR: Attempting to update app cache entry but hashsum is not a string key parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 13 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/7bb505e0-0720-482b-81c0-42d8275629ee_calibrate_891943_2.stdout parsl.dataflow.dflow INFO: Standard error for task 13 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/7bb505e0-0720-482b-81c0-42d8275629ee_calibrate_891943_2.stderr parsl.dataflow.dflow INFO: Standard output for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stdout parsl.dataflow.dflow INFO: Standard error for task 12 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891943/0b140933-6594-4abe-904e-a77bd1c5727e_characterizeImage_891943_2.stderr parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 14 try 1 failed parsl.dataflow.dflow ERROR: Task 14 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app characterizeImage failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry 2fc4d608c66524713652b42a6b52a21d with result from task 14 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Task 15 failed due to dependency failure parsl.dataflow.dflow DEBUG: Task 15 try 0 failed parsl.dataflow.dflow INFO: Task 15 failed due to dependency failure so skipping retries parsl.dataflow.memoization ERROR: Attempting to update app cache entry but hashsum is not a string key parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 15 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/62632e41-8384-4ec8-a78b-7a64aad5c2de_calibrate_891944_2.stdout parsl.dataflow.dflow INFO: Standard error for task 15 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891944/62632e41-8384-4ec8-a78b-7a64aad5c2de_calibrate_891944_2.stderr parsl.dataflow.dflow INFO: Standard output for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stdout parsl.dataflow.dflow INFO: Standard error for task 14 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891944/b5d27417-9f1b-41a3-9fa5-7da5fea5ebec_characterizeImage_891944_2.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 5 parsl.dataflow.strategy DEBUG: Executor multi has 5 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 16 try 1 failed parsl.dataflow.dflow ERROR: Task 16 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app characterizeImage failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry 3c7e5607af9b7f3e7b3727f498d831a6 with result from task 16 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Task 17 failed due to dependency failure parsl.dataflow.dflow DEBUG: Task 17 try 0 failed parsl.dataflow.dflow INFO: Task 17 failed due to dependency failure so skipping retries parsl.dataflow.memoization ERROR: Attempting to update app cache entry but hashsum is not a string key parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 17 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/c97700d1-71a3-4fe0-a0a2-cf3da67e1bc0_calibrate_891835_2.stdout parsl.dataflow.dflow INFO: Standard error for task 17 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/c97700d1-71a3-4fe0-a0a2-cf3da67e1bc0_calibrate_891835_2.stderr parsl.dataflow.dflow INFO: Standard output for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stdout parsl.dataflow.dflow INFO: Standard error for task 16 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/characterizeImage/891835/8f711b92-3b0f-41e0-8a97-20c02e111714_characterizeImage_891835_2.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 4 parsl.dataflow.strategy DEBUG: Executor multi has 4 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 4 parsl.dataflow.strategy DEBUG: Executor multi has 4 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 2 try 1 failed parsl.dataflow.dflow ERROR: Task 2 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app calibrate failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry 2fb36e3264a6d49950f9b9e4cacfb16f with result from task 2 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stdout parsl.dataflow.dflow INFO: Standard error for task 2 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891836/ebcc0776-d294-4f0b-b4f6-9ecf19dfe60f_calibrate_891836_61.stderr 2024-03-13 08:37:09 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:37:09 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING 2024-03-13 08:37:09 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 3 parsl.dataflow.strategy DEBUG: Executor multi has 3 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 3 parsl.dataflow.strategy DEBUG: Executor multi has 3 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 3: no changes necessary to current block load parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 3 try 1 failed parsl.dataflow.dflow ERROR: Task 3 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app calibrate failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry ee452db849529c5ee424e053317bcecb with result from task 3 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stdout parsl.dataflow.dflow INFO: Standard error for task 3 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891835/65d4ce58-0738-4f49-8140-644ae980f189_calibrate_891835_61.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 2 parsl.dataflow.strategy DEBUG: Executor multi has 2 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 2 parsl.dataflow.strategy DEBUG: Executor multi has 2 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 2 parsl.dataflow.strategy DEBUG: Executor multi has 2 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 2 parsl.dataflow.strategy DEBUG: Executor multi has 2 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 2024-03-13 08:37:39 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:37:39 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING 2024-03-13 08:37:39 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro parsl.providers.slurm.slurm DEBUG: Executing squeue --noheader --format='%i %t' --job '17008852,17008853' parsl.providers.slurm.slurm DEBUG: squeue returned 17008852 R 17008853 R parsl.providers.slurm.slurm DEBUG: Updating job 17008852 with slurm status R to parsl state JobState.RUNNING parsl.providers.slurm.slurm DEBUG: Updating job 17008853 with slurm status R to parsl state JobState.RUNNING parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 2 parsl.dataflow.strategy DEBUG: Executor multi has 2 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 2 parsl.dataflow.strategy DEBUG: Executor multi has 2 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 5 try 1 failed parsl.dataflow.dflow ERROR: Task 5 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app calibrate failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry 2e4bd8f79106822b2a2d3ccc27ffc210 with result from task 5 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Standard output for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stdout parsl.dataflow.dflow INFO: Standard error for task 5 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891943/30bb4315-f273-4b09-bafa-fc13ae10f1e2_calibrate_891943_61.stderr parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 1 parsl.dataflow.strategy DEBUG: Executor multi has 1 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 1 parsl.dataflow.strategy DEBUG: Executor multi has 1 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 1 parsl.dataflow.strategy DEBUG: Executor multi has 1 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.dataflow.strategy DEBUG: general strategy starting with strategy_type simple for 1 executors parsl.dataflow.strategy DEBUG: Strategizing for executor multi parsl.dataflow.strategy DEBUG: Slot ratio calculation: active_slots = 3, active_tasks = 1 parsl.dataflow.strategy DEBUG: Executor multi has 1 active tasks, 3/0 running/pending blocks, and 4 connected workers parsl.dataflow.strategy DEBUG: Strategy case 4b: more slots than tasks parsl.dataflow.strategy DEBUG: This strategy does not support scaling in parsl.process_loggers DEBUG: Normal ending for _general_strategy on thread JobStatusPoller-Timer-Thread-22563740944336 parsl.app.errors DEBUG: Reraising exception of type parsl.dataflow.dflow DEBUG: Task 4 try 1 failed parsl.dataflow.dflow ERROR: Task 4 failed after 1 retry attempts Traceback (most recent call last): File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 300, in handle_exec_update res = self._unwrap_remote_exception_wrapper(future) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/dataflow/dflow.py", line 566, in _unwrap_remote_exception_wrapper result.reraise() File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 123, in reraise reraise(t, v, v.__traceback__) File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/six.py", line 719, in reraise raise value File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/errors.py", line 146, in wrapper return func(*args, **kwargs) ^^^^^^^^^^^^^^^^^ File "/mmfs1/gscratch/dirac/shared/opt/conda/envs/lsst-scipipe-8.0.0/lib/python3.11/site-packages/parsl/app/bash.py", line 86, in remote_side_bash_executor raise pe.BashExitFailure(func_name, proc.returncode) ^^^^^^^^^^^^^^^^^ parsl.app.errors.BashExitFailure: bash_app calibrate failed with unix exit code 1 parsl.dataflow.memoization DEBUG: Storing app cache entry b9feccde80c897279b6a31da655f1233 with result from task 4 parsl.dataflow.dflow INFO: DFK cleanup initiated parsl.dataflow.dflow INFO: Summary of tasks in DFK: parsl.dataflow.dflow INFO: Tasks in state States.unsched: 0 parsl.dataflow.dflow INFO: Tasks in state States.pending: 0 parsl.dataflow.dflow INFO: Tasks in state States.running: 0 parsl.dataflow.dflow INFO: Tasks in state States.exec_done: 0 parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Tasks in state States.failed: 12 parsl.dataflow.dflow INFO: Standard output for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stdout parsl.dataflow.dflow INFO: Tasks in state States.dep_fail: 6 parsl.dataflow.dflow INFO: Standard error for task 4 available at /mmfs1/home/stevengs/dirac/DEEP/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/submit/DEEP/20190829/B1c/science#step1/20240313T083341Z/logs/calibrate/891834/0c674fcb-2af6-4bf9-9df0-d71575369203_calibrate_891834_61.stderr parsl.dataflow.dflow INFO: Tasks in state States.launched: 0 parsl.dataflow.dflow INFO: Tasks in state States.fail_retryable: 0 parsl.dataflow.dflow INFO: Tasks in state States.memo_done: 0 parsl.dataflow.dflow INFO: Tasks in state States.joining: 0 parsl.dataflow.dflow INFO: Tasks in state States.running_ended: 0 parsl.dataflow.dflow INFO: End of summary parsl.dataflow.dflow WARNING: No tasks checkpointed so far in this run. Please ensure caching is enabled parsl.dataflow.dflow INFO: Closing job status poller parsl.dataflow.dflow INFO: Terminated job status poller parsl.dataflow.dflow INFO: Scaling in and shutting down executors parsl.dataflow.dflow INFO: Scaling in executor multi parsl.executors.high_throughput.executor DEBUG: Scale in called, blocks=3, block_ids=[] parsl.executors.high_throughput.executor DEBUG: Scale in selecting from 3 blocks parsl.executors.high_throughput.executor DEBUG: Sending hold to manager: 05a75a35b36c parsl.executors.high_throughput.executor DEBUG: Sent hold request to manager: 05a75a35b36c parsl.executors.high_throughput.executor DEBUG: Sending hold to manager: d4bd5f994bd0 parsl.executors.high_throughput.executor DEBUG: Sent hold request to manager: d4bd5f994bd0 parsl.executors.high_throughput.executor DEBUG: Sending hold to manager: 32e68223595e parsl.executors.high_throughput.executor DEBUG: Sent hold request to manager: 32e68223595e 2024-03-13 08:38:06 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro 2024-03-13 08:38:06 proc_lsst.multi:201 [INFO] cancelling 17008853 on provider astro proc_lsst.multi INFO: cancelling 17008853 on provider astro 2024-03-13 08:38:06 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro 2024-03-13 08:38:06 proc_lsst.multi:201 [INFO] cancelling 17008852 on provider astro proc_lsst.multi INFO: cancelling 17008852 on provider astro 2024-03-13 08:38:06 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:38:06 proc_lsst.multi:201 [INFO] cancelling 26708 on provider local proc_lsst.multi INFO: cancelling 26708 on provider local parsl.providers.local.local DEBUG: Terminating job/proc_id: 26708 parsl.dataflow.dflow INFO: Shutting down executor multi 2024-03-13 08:38:06 proc_lsst.multi:40 [INFO] Cancelling all provider resources proc_lsst.multi INFO: Cancelling all provider resources 2024-03-13 08:38:06 proc_lsst.multi:47 [INFO] new jobs since last cancel ['17008852', '17008853', '26708'] proc_lsst.multi INFO: new jobs since last cancel ['17008852', '17008853', '26708'] 2024-03-13 08:38:06 proc_lsst.multi:146 [INFO] found job 17008852 in provider astro proc_lsst.multi INFO: found job 17008852 in provider astro 2024-03-13 08:38:06 proc_lsst.multi:201 [INFO] cancelling 17008852 on provider astro proc_lsst.multi INFO: cancelling 17008852 on provider astro 2024-03-13 08:38:06 proc_lsst.multi:146 [INFO] found job 17008853 in provider astro proc_lsst.multi INFO: found job 17008853 in provider astro 2024-03-13 08:38:06 proc_lsst.multi:201 [INFO] cancelling 17008853 on provider astro proc_lsst.multi INFO: cancelling 17008853 on provider astro 2024-03-13 08:38:06 proc_lsst.multi:146 [INFO] found job 26708 in provider local proc_lsst.multi INFO: found job 26708 in provider local 2024-03-13 08:38:06 proc_lsst.multi:201 [INFO] cancelling 26708 on provider local proc_lsst.multi INFO: cancelling 26708 on provider local parsl.providers.local.local DEBUG: Terminating job/proc_id: 26708 parsl.providers.local.local WARNING: Failed to kill PID: 26708 and child processes on local 2024-03-13 08:38:08 proc_lsst.multi:50 [INFO] no new jobs since last cancel, resuming executor shutdown proc_lsst.multi INFO: no new jobs since last cancel, resuming executor shutdown parsl.executors.high_throughput.executor INFO: Attempting HighThroughputExecutor shutdown parsl.executors.high_throughput.executor INFO: Finished HighThroughputExecutor shutdown attempt parsl.dataflow.dflow INFO: Shut down executor multi parsl.dataflow.dflow INFO: Shutting down executor _parsl_internal parsl.executors.threads DEBUG: Shutting down executor, which involves waiting for running tasks to complete parsl.executors.threads DEBUG: Done with executor shutdown parsl.dataflow.dflow INFO: Shut down executor _parsl_internal parsl.dataflow.dflow INFO: Terminated executors parsl.dataflow.dflow INFO: DFK cleanup complete parsl.process_loggers DEBUG: Normal ending for cleanup on thread MainThread lsst.ctrl.bps.submit INFO: Completed submitting to a workflow management system: Took 251.9792 seconds lsst.ctrl.bps.drivers INFO: Run 'DEEP_20190829_B1c_science#step1_20240313T083341Z' submitted for execution with id 'None' lsst.ctrl.bps.drivers INFO: Completed submit stage: Took 251.9857 seconds; current memory usage: 0.345 Gibyte, delta: 0.007 Gibyte, peak delta: 0.007 Gibyte lsst.ctrl.bps.drivers INFO: Completed entire submission process: Took 262.7460 seconds; current memory usage: 0.345 Gibyte, delta: 0.209 Gibyte, peak delta: 0.209 Gibyte lsst.ctrl.bps.drivers INFO: Peak memory usage for bps process 0.346 Gibyte (main), 0.345 Gibyte (largest child process) Run Id: None Run Name: DEEP_20190829_B1c_science#step1_20240313T083341Z parsl.dataflow.dflow INFO: python process is exiting, but DFK has already been cleaned up real 4m24.795s user 0m23.457s sys 0m5.213s