R Under development (unstable) (2025-06-04 r88278 ucrt) -- "Unsuffered Consequences" Copyright (C) 2025 The R Foundation for Statistical Computing Platform: x86_64-w64-mingw32/x64 R is free software and comes with ABSOLUTELY NO WARRANTY. You are welcome to redistribute it under certain conditions. Type 'license()' or 'licence()' for distribution details. R is a collaborative project with many contributors. Type 'contributors()' for more information and 'citation()' on how to cite R or R packages in publications. Type 'demo()' for some demos, 'help()' for on-line help, or 'help.start()' for an HTML browser interface to help. Type 'q()' to quit R. > ## This runs testme test script inst/testme/test-cluster-connection-clashes.R > ## Don't edit - it was autogenerated by inst/testme/deploy.R > future:::testme("cluster-connection-clashes") Test 'cluster-connection-clashes' ... Sourcing 9 prologue scripts ... 01/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/001.load.R' 02/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/002.record-state.R' 03/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/030.imports.R' 04/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/050.utils.R' 05/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/090.context.R' 06/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/090.options.R' 07/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/091.envvars.R' 08/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/099.future-setup.R' 09/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/995.detrius-connections.R' Sourcing 9 prologue scripts ... done Running test script: 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/test-cluster-connection-clashes.R' > library(future) [05:57:25.792] Option 'future.startup.script': TRUE [05:57:25.794] Future startup scripts considered: '.future.R', '~/.future.R' [05:57:25.795] Future startup scripts found: > message("all.equal() for connection ...") all.equal() for connection ... > con1 <- rawConnection(raw()) > close(con1) > con2 <- rawConnection(raw()) > close(con2) > stopifnot(!isTRUE(all.equal(con1, con2))) > message("all.equal() for connection ... done") all.equal() for connection ... done > message("all.equal() for cluster backend ...") all.equal() for cluster backend ... > for (kk in 1:3) { + message("Iteration #", kk) + cl <- parallel::makeCluster(1) + plan(cluster, workers = cl) + fs <- lapply(1:2, FU .... [TRUNCATED] Iteration #1 [05:57:26.090] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.091] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... [05:57:26.092] | : all.equal() for FutureStrategyList ... [05:57:26.092] | : . New stack: [05:57:26.092] | : . List of 1 [05:57:26.092] | : . $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.092] | : . envir = parent.frame()) [05:57:26.092] | : . ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.092] | : . ..- attr(*, "init")= logi TRUE [05:57:26.092] | : . ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.092] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.092] | : . .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.092] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.092] | : . ..- attr(*, "tweaks")=List of 1 [05:57:26.092] | : . .. ..$ workers:List of 1 [05:57:26.092] | : . .. .. ..$ :List of 3 [05:57:26.092] | : . .. .. .. ..$ con : 'sockconn' int 4 [05:57:26.092] | : . .. .. .. .. ..- attr(*, "conn_id")= [05:57:26.092] | : . .. .. .. ..$ host: chr "localhost" [05:57:26.092] | : . .. .. .. ..$ rank: num 0 [05:57:26.092] | : . .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.092] | : . .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.092] | : . ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.092] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:26.104] | : . Old stack: [05:57:26.104] | : . List of 1 [05:57:26.104] | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:26.104] | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:26.104] | : . ..- attr(*, "init")= logi TRUE [05:57:26.104] | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:26.104] | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:26.104] | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:26.104] | : . ..- attr(*, "call")= language plan(sequential) [05:57:26.104] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:26.110] | : . Not identical [05:57:26.110] | : . all.equal() for future ... [05:57:26.110] | : . ' List of 2 [05:57:26.110] | : . ' $ target :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.110] | : . ' envir = parent.frame()) [05:57:26.110] | : . ' ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.110] | : . ' ..- attr(*, "init")= logi TRUE [05:57:26.110] | : . ' ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.110] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.110] | : . ' .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.110] | : . ' ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.110] | : . ' ..- attr(*, "tweaks")=List of 1 [05:57:26.110] | : . ' .. ..$ workers:List of 1 [05:57:26.110] | : . ' .. .. ..$ :List of 3 [05:57:26.110] | : . ' .. .. .. ..$ con : 'sockconn' int 4 [05:57:26.110] | : . ' .. .. .. .. ..- attr(*, "conn_id")= [05:57:26.110] | : . ' .. .. .. ..$ host: chr "localhost" [05:57:26.110] | : . ' .. .. .. ..$ rank: num 0 [05:57:26.110] | : . ' .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.110] | : . ' .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.110] | : . ' ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.110] | : . ' $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:26.110] | : . ' ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:26.110] | : . ' ..- attr(*, "init")= logi TRUE [05:57:26.110] | : . ' ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:26.110] | : . ' .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:26.110] | : . ' ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:26.110] | : . ' ..- attr(*, "call")= language plan(sequential) [05:57:26.124] | : . ' Formals differ [05:57:26.124] | : . all.equal() for future ... done [05:57:26.125] | : . Future strategies differ at level 1 [05:57:26.125] | : all.equal() for FutureStrategyList ... done [05:57:26.125] | : plan(): Setting new future backend stack: [05:57:26.126] | : List of future strategies: [05:57:26.126] | : 1. cluster: [05:57:26.126] | : - args: function (..., workers = "", envir = parent.frame()) [05:57:26.126] | : - tweaked: TRUE [05:57:26.126] | : - call: plan(cluster, workers = cl) [05:57:26.127] | : List of 1 [05:57:26.127] | : $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.127] | : envir = parent.frame()) [05:57:26.127] | : ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.127] | : ..- attr(*, "init")= logi TRUE [05:57:26.127] | : ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.127] | : earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.127] | : .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.127] | : ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.127] | : ..- attr(*, "tweaks")=List of 1 [05:57:26.127] | : .. ..$ workers:List of 1 [05:57:26.127] | : .. .. ..$ :List of 3 [05:57:26.127] | : .. .. .. ..$ con : 'sockconn' int 4 [05:57:26.127] | : .. .. .. .. ..- attr(*, "conn_id")= [05:57:26.127] | : .. .. .. ..$ host: chr "localhost" [05:57:26.127] | : .. .. .. ..$ rank: num 0 [05:57:26.127] | : .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.127] | : .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.127] | : ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.127] | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:26.140] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... [05:57:26.140] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.140] | : . ' Getting current ("next") strategy: 'FutureStrategy', 'sequential', 'uniprocess', 'future', 'function' [05:57:26.141] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:26.141] | : . Legacy shutdown of cluster workers ... [05:57:26.141] | : . ' Stopping existing cluster ... [05:57:26.142] | : . ' , No pre-existing cluster. Skipping [05:57:26.142] | : . ' Stopping existing cluster ... done [05:57:26.142] | : . Legacy shutdown of cluster workers ... done [05:57:26.142] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... done [05:57:26.143] | : plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... [05:57:26.143] | : . function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.143] | : . envir = parent.frame()) [05:57:26.143] | : . - attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.143] | : . - attr(*, "init")= logi TRUE [05:57:26.143] | : . - attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.143] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.143] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.143] | : . - attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.143] | : . - attr(*, "tweaks")=List of 1 [05:57:26.143] | : . ..$ workers:List of 1 [05:57:26.143] | : . .. ..$ :List of 3 [05:57:26.143] | : . .. .. ..$ con : 'sockconn' int 4 [05:57:26.143] | : . .. .. .. ..- attr(*, "conn_id")= [05:57:26.143] | : . .. .. ..$ host: chr "localhost" [05:57:26.143] | : . .. .. ..$ rank: num 0 [05:57:26.143] | : . .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.143] | : . .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.143] | : . - attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.153] | : . init: TRUE [05:57:26.154] | : . makeFutureBackend() ... [05:57:26.154] | : . ' Backend function: <'NULL'> [05:57:26.155] | : . ' Evaluator tweak arguments: [n=1] [05:57:26.155] | : . ' List of 1 [05:57:26.155] | : . ' $ workers:List of 1 [05:57:26.155] | : . ' ..$ :List of 3 [05:57:26.155] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:26.155] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:26.155] | : . ' .. ..$ host: chr "localhost" [05:57:26.155] | : . ' .. ..$ rank: num 0 [05:57:26.155] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.155] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.161] | : . ' Evaluator formal arguments: [n=1] [05:57:26.161] | : . ' List of 1 [05:57:26.161] | : . ' $ workers:List of 1 [05:57:26.161] | : . ' ..$ :List of 3 [05:57:26.161] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:26.161] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:26.161] | : . ' .. ..$ host: chr "localhost" [05:57:26.161] | : . ' .. ..$ rank: num 0 [05:57:26.161] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.161] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.166] | : . ' Backend factory arguments: [n=1] [05:57:26.167] | : . ' Dotted pair list of 1 [05:57:26.167] | : . ' $ workers:List of 1 [05:57:26.167] | : . ' ..$ :List of 3 [05:57:26.167] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:26.167] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:26.167] | : . ' .. ..$ host: chr "localhost" [05:57:26.167] | : . ' .. ..$ rank: num 0 [05:57:26.167] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.167] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.172] | : . ' ClusterFutureBackend(..., persistent = FALSE, gc = TRUE, earlySignal = TRUE) ... [05:57:26.173] | : . ' , Stopping existing cluster ... [05:57:26.173] | : . ' , ; No pre-existing cluster. Skipping [05:57:26.173] | : . ' , Stopping existing cluster ... done [05:57:26.174] | : . ' , Number of workers: 1 [05:57:26.174] | : . ' , Generated workers UUID [05:57:26.174] | : . ' , Workers UUID: '37e5752128e4483a3ce8b7fda2d6c13d' [05:57:26.178] | : . ' ClusterFutureBackend(..., persistent = FALSE, gc = TRUE, earlySignal = TRUE) ... done [05:57:26.178] | : . ' Backend: <'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment'> [05:57:26.178] | : . makeFutureBackend() ... done [05:57:26.179] | : plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... done [05:57:26.179] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.179] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:26.180] | : plan(): nbrOfWorkers() = 1 [05:57:26.180] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done [05:57:26.180] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:26.181] future(..., label = NULL) ... [05:57:26.181] | lazy: FALSE [05:57:26.181] | stdout: TRUE [05:57:26.182] | conditions: [n=1] 'condition' [05:57:26.182] | gc: FALSE [05:57:26.182] | earlySignal: FALSE [05:57:26.184] | getGlobalsAndPackages() ... [05:57:26.184] | : Searching for globals ... [05:57:26.204] | : . globals found: [3] '[[', 'X', 'i' [05:57:26.204] | : Searching for globals ... done [05:57:26.204] | : Resolving globals: FALSE [05:57:26.205] | : Search for packages associated with the globals ... [05:57:26.205] | : . Packages associated with globals: [1] 'base' [05:57:26.206] | : . Packages: [1] 'base' [05:57:26.206] | : Search for packages associated with the globals ... done [05:57:26.207] | : Packages after dropping 'base': [0] [05:57:26.207] | : globals: [2] 'X', 'i' [05:57:26.207] | : packages: [0] [05:57:26.208] | getGlobalsAndPackages() ... done [05:57:26.209] | run() for 'Future' () ... [05:57:26.209] | : state: 'created' [05:57:26.210] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.210] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:26.210] | : Using ClusterFutureBackend ... [05:57:26.210] | : . Number of futures since start: 0 (0 created, 0 launched, 0 finished) [05:57:26.211] | : . Launching futures ... [05:57:26.212] | : . ' launchFuture() for ClusterFutureBackend ... [05:57:26.212] | : . ' , Workers: [n=1] [05:57:26.212] | : . ' , socket cluster with 1 nodes on host 'localhost' [05:57:26.213] | : . ' , FutureRegistry: 'workers-37e5752128e4483a3ce8b7fda2d6c13d' [05:57:26.213] | : . ' , requestWorker() ... [05:57:26.213] | : . ' , ; requestNode() ... [05:57:26.214] | : . ' , ; ` Number of workers: 1 [05:57:26.214] | : . ' , ; ` Polling for a free worker ... [05:57:26.214] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:26.215] | : . ' , ; ` | : Created empty registry 'workers-37e5752128e4483a3ce8b7fda2d6c13d' [05:57:26.215] | : . ' , ; ` | : Listing all futures [05:57:26.215] | : . ' , ; ` | : Number of registered futures: 0 [05:57:26.215] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:26.216] | : . ' , ; ` | Total time: 0 [05:57:26.216] | : . ' , ; ` Polling for a free worker ... done [05:57:26.216] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:26.216] | : . ' , ; ` | Listing all futures [05:57:26.217] | : . ' , ; ` | Number of registered futures: 0 [05:57:26.221] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:26.221] | : . ' , ; ` avail: [n=1] '1' [05:57:26.221] | : . ' , ; ` Index of first available worker: 1 [05:57:26.222] | : . ' , ; ` Validate that the worker is functional ... [05:57:26.372] | : . ' , ; ` | Worker is functional [05:57:26.373] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:26.373] | : . ' , ; ` | : Listing all futures [05:57:26.373] | : . ' , ; ` | : Number of registered futures: 0 [05:57:26.373] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:26.374] | : . ' , ; ` Validate that the worker is functional ... done [05:57:26.374] | : . ' , ; requestNode() ... done [05:57:26.374] | : . ' , ; cluster node index: 1 [05:57:26.375] | : . ' , requestWorker() ... done [05:57:26.375] | : . ' , eraseGlobalEnvironment() ... [05:57:26.376] | : . ' , eraseGlobalEnvironment() ... done [05:57:26.376] | : . ' , launchFuture() ... [05:57:26.377] | : . ' , ; cluster node index: 1 [05:57:26.377] | : . ' , ; getFutureData() ... [05:57:26.378] | : . ' , ; ` getFutureCore() ... [05:57:26.378] | : . ' , ; ` | Packages needed by the future expression (n = 0): [05:57:26.378] | : . ' , ; ` getFutureCore() ... done [05:57:26.379] | : . ' , ; ` getFutureCapture() ... [05:57:26.379] | : . ' , ; ` getFutureCapture() ... done [05:57:26.380] | : . ' , ; ` getFutureContext() ... [05:57:26.380] | : . ' , ; ` | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.380] | : . ' , ; ` | : Getting stack without first backend: [n=0] [05:57:26.381] | : . ' , ; ` | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:26.381] | : . ' , ; ` | Packages needed by future backend (n = 0): [05:57:26.381] | : . ' , ; ` getFutureContext() ... done [05:57:26.382] | : . ' , ; getFutureData() ... done [05:57:26.383] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... [05:57:26.384] | : . ' , ; ` Appended future to position #1 [05:57:26.384] | : . ' , ; ` Number of registered futures: 1 [05:57:26.384] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... done [05:57:26.385] | : . ' , launchFuture() ... done [05:57:26.385] | : . ' , ClusterFuture started [05:57:26.385] | : . ' launchFuture() for ClusterFutureBackend ... done [05:57:26.386] | : . Launching futures ... done [05:57:26.386] | : . Future launched: 'ClusterFuture', 'MultiprocessFuture', 'Future' [05:57:26.386] | : Using ClusterFutureBackend ... done [05:57:26.387] | run() for 'Future' () ... done [05:57:26.387] future(..., label = NULL) ... done [05:57:26.387] future(..., label = NULL) ... [05:57:26.388] | lazy: FALSE [05:57:26.388] | stdout: TRUE [05:57:26.388] | conditions: [n=1] 'condition' [05:57:26.389] | gc: FALSE [05:57:26.389] | earlySignal: FALSE [05:57:26.389] | getGlobalsAndPackages() ... [05:57:26.390] | : Searching for globals ... [05:57:26.399] | : . globals found: [3] '[[', 'X', 'i' [05:57:26.399] | : Searching for globals ... done [05:57:26.400] | : Resolving globals: FALSE [05:57:26.400] | : Search for packages associated with the globals ... [05:57:26.401] | : . Packages associated with globals: [1] 'base' [05:57:26.401] | : . Packages: [1] 'base' [05:57:26.402] | : Search for packages associated with the globals ... done [05:57:26.402] | : Packages after dropping 'base': [0] [05:57:26.402] | : globals: [2] 'X', 'i' [05:57:26.403] | : packages: [0] [05:57:26.403] | getGlobalsAndPackages() ... done [05:57:26.404] | run() for 'Future' () ... [05:57:26.404] | : state: 'created' [05:57:26.404] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.405] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:26.405] | : Using ClusterFutureBackend ... [05:57:26.405] | : . Number of futures since start: 1 (1 created, 1 launched, 0 finished) [05:57:26.406] | : . Launching futures ... [05:57:26.406] | : . ' launchFuture() for ClusterFutureBackend ... [05:57:26.407] | : . ' , Workers: [n=1] [05:57:26.407] | : . ' , socket cluster with 1 nodes on host 'localhost' [05:57:26.408] | : . ' , FutureRegistry: 'workers-37e5752128e4483a3ce8b7fda2d6c13d' [05:57:26.408] | : . ' , requestWorker() ... [05:57:26.408] | : . ' , ; requestNode() ... [05:57:26.449] | : . ' , ; ` Number of workers: 1 [05:57:26.450] | : . ' , ; ` Polling for a free worker ... [05:57:26.450] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:26.450] | : . ' , ; ` | : Listing all futures [05:57:26.451] | : . ' , ; ` | : Number of registered futures: 1 [05:57:26.451] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:26.451] | : . ' , ; ` | Poll #1 (0): usedNodes() = 1, workers = 1 [05:57:26.464] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'collect-first', earlySignal = 1) ... [05:57:26.465] | : . ' , ; ` | : collectValues('workers-37e5752128e4483a3ce8b7fda2d6c13d', firstOnly = TRUE) ... [05:57:26.465] | : . ' , ; ` | : . resolved() for ClusterFuture () ... [05:57:26.466] | : . ' , ; ` | : . ' Cluster node socket connection: index=4, id=139 [05:57:26.467] | : . ' , ; ` | : . ' assertValidConnection() ... [05:57:26.467] | : . ' , ; ` | : . ' , cluster node index: 1 [05:57:26.467] | : . ' , ; ` | : . ' assertValidConnection() ... done [05:57:26.474] | : . ' , ; ` | : . ' receiveMessageFromWorker() for ClusterFuture ... [05:57:26.474] | : . ' , ; ` | : . ' , cluster node index: 1 [05:57:26.475] | : . ' , ; ` | : . ' , [1] TRUE [05:57:26.475] | : . ' , ; ` | : . ' , received data: [05:57:26.476] | : . ' , ; ` | : . ' , List of 5 [05:57:26.476] | : . ' , ; ` | : . ' , $ type : chr "VALUE" [05:57:26.476] | : . ' , ; ` | : . ' , $ value :List of 16 [05:57:26.476] | : . ' , ; ` | : . ' , ..$ value : int 1 [05:57:26.476] | : . ' , ; ` | : . ' , ..$ visible : logi TRUE [05:57:26.476] | : . ' , ; ` | : . ' , ..$ stdout : chr "" [05:57:26.476] | : . ' , ; ` | : . ' , ..$ conditions : list() [05:57:26.476] | : . ' , ; ` | : . ' , ..$ rng : logi FALSE [05:57:26.476] | : . ' , ; ` | : . ' , ..$ seed : NULL [05:57:26.476] | : . ' , ; ` | : . ' , ..$ misuseGlobalEnv : NULL [05:57:26.476] | : . ' , ; ` | : . ' , ..$ misuseConnections :List of 3 [05:57:26.476] | : . ' , ; ` | : . ' , .. ..$ added : NULL [05:57:26.476] | : . ' , ; ` | : . ' , .. ..$ removed : NULL [05:57:26.476] | : . ' , ; ` | : . ' , .. ..$ replaced: NULL [05:57:26.476] | : . ' , ; ` | : . ' , ..$ misuseDevices : NULL [05:57:26.476] | : . ' , ; ` | : . ' , ..$ misuseDefaultDevice: list() [05:57:26.476] | : . ' , ; ` | : . ' , ..$ started : POSIXct[1:1], format: "2025-06-05 05:57:26" [05:57:26.476] | : . ' , ; ` | : . ' , ..$ finished : POSIXct[1:1], format: "2025-06-05 05:57:26" [05:57:26.476] | : . ' , ; ` | : . ' , ..$ uuid : chr [1:2] "e6fc8766d87d810603f2d8674725d8b6" "1" [05:57:26.476] | : . ' , ; ` | : . ' , ..$ session_uuid : chr "a85e9e29a0f0e4ec00dc76a60ea26de1" [05:57:26.476] | : . ' , ; ` | : . ' , .. ..- attr(*, "source")=List of 5 [05:57:26.476] | : . ' , ; ` | : . ' , .. .. ..$ host : Named chr "CRANWIN3" [05:57:26.476] | : . ' , ; ` | : . ' , .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [05:57:26.476] | : . ' , ; ` | : . ' , .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:26.476] | : . ' , ; ` | : . ' , .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:26.476] | : . ' , ; ` | : . ' , .. .. ..$ pid : int 163468 [05:57:26.476] | : . ' , ; ` | : . ' , .. .. ..$ time : POSIXct[1:1], format: "2025-06-05 05:57:26" [05:57:26.476] | : . ' , ; ` | : . ' , .. .. ..$ random: int 2147483647 [05:57:26.476] | : . ' , ; ` | : . ' , ..$ r_info :List of 4 [05:57:26.476] | : . ' , ; ` | : . ' , .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [05:57:26.476] | : . ' , ; ` | : . ' , .. .. ..$ : int [1:3] 4 6 0 [05:57:26.476] | : . ' , ; ` | : . ' , .. ..$ os : chr "windows" [05:57:26.476] | : . ' , ; ` | : . ' , .. ..$ os_name : chr "Windows" [05:57:26.476] | : . ' , ; ` | : . ' , .. ..$ captures_utf8: logi TRUE [05:57:26.476] | : . ' , ; ` | : . ' , ..$ version : chr "1.8" [05:57:26.476] | : . ' , ; ` | : . ' , ..- attr(*, "class")= chr "FutureResult" [05:57:26.476] | : . ' , ; ` | : . ' , $ success: logi TRUE [05:57:26.476] | : . ' , ; ` | : . ' , $ time : 'proc_time' Named num [1:5] 0.06 0.01 0.1 NA NA [05:57:26.476] | : . ' , ; ` | : . ' , ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [05:57:26.476] | : . ' , ; ` | : . ' , $ tag : NULL [05:57:26.539] | : . ' , ; ` | : . ' , Received FutureResult [05:57:26.539] | : . ' , ; ` | : . ' , FutureResult: [05:57:26.539] | : . ' , ; ` | : . ' , value: 'integer' [05:57:26.539] | : . ' , ; ` | : . ' , visible: TRUE [05:57:26.539] | : . ' , ; ` | : . ' , stdout: character [05:57:26.539] | : . ' , ; ` | : . ' , conditions: [n = 0] [05:57:26.539] | : . ' , ; ` | : . ' , RNG used: FALSE [05:57:26.539] | : . ' , ; ` | : . ' , duration: 0.08567786 secs (started 2025-06-05 05:57:26.385384) [05:57:26.539] | : . ' , ; ` | : . ' , version: 1.8 [05:57:26.541] | : . ' , ; ` | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... [05:57:26.545] | : . ' , ; ` | : . ' , ; Removed future from position #1 [05:57:26.546] | : . ' , ; ` | : . ' , ; Number of registered futures: 0 [05:57:26.546] | : . ' , ; ` | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... done [05:57:26.546] | : . ' , ; ` | : . ' , Erased future from future backend [05:57:26.547] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:26.548] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:26.548] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:26.548] | : . ' , ; ` | : . ' , signalConditions() ... [05:57:26.548] | : . ' , ; ` | : . ' , ; include = 'immediateCondition' [05:57:26.549] | : . ' , ; ` | : . ' , ; exclude = [05:57:26.549] | : . ' , ; ` | : . ' , ; resignal = FALSE [05:57:26.549] | : . ' , ; ` | : . ' , ; Number of conditions: 0 [05:57:26.550] | : . ' , ; ` | : . ' , ; int 0 [05:57:26.551] | : . ' , ; ` | : . ' , signalConditions() ... done [05:57:26.551] | : . ' , ; ` | : . ' receiveMessageFromWorker() for ClusterFuture ... done [05:57:26.551] | : . ' , ; ` | : . ' receiveMessageFromWorker() returned object of class FutureResult; resolved [05:57:26.551] | : . ' , ; ` | : . resolved() for ClusterFuture () ... done [05:57:26.552] | : . ' , ; ` | : . assertFutureResult() ... [05:57:26.552] | : . ' , ; ` | : . ' Future uuid: e6fc8766d87d810603f2d8674725d8b6[05:57:26.552] | : . ' , ; ` | : . ' Future uuid: 1 [05:57:26.553] | : . ' , ; ` | : . ' identical; success [05:57:26.553] | : . ' , ; ` | : . assertFutureResult() ... done [05:57:26.553] | : . ' , ; ` | : . Future at position #1 is resolved ... [05:57:26.554] | : . ' , ; ` | : . ' value() for ClusterFuture () ... [05:57:26.555] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:26.555] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:26.555] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:26.555] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:26.556] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:26.556] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:26.556] | : . ' , ; ` | : . ' , signalConditions() ... [05:57:26.557] | : . ' , ; ` | : . ' , ; include = 'immediateCondition' [05:57:26.557] | : . ' , ; ` | : . ' , ; exclude = [05:57:26.557] | : . ' , ; ` | : . ' , ; resignal = FALSE [05:57:26.558] | : . ' , ; ` | : . ' , ; Number of conditions: 0 [05:57:26.558] | : . ' , ; ` | : . ' , ; int 0 [05:57:26.559] | : . ' , ; ` | : . ' , signalConditions() ... done [05:57:26.559] | : . ' , ; ` | : . ' , check for misuse ... [05:57:26.559] | : . ' , ; ` | : . ' , check for misuse ... done [05:57:26.560] | : . ' , ; ` | : . ' value() for ClusterFuture () ... done [05:57:26.560] | : . ' , ; ` | : . Future at position #1 is resolved ... done [05:57:26.561] | : . ' , ; ` | : collectValues('workers-37e5752128e4483a3ce8b7fda2d6c13d', firstOnly = TRUE) ... done [05:57:26.561] | : . ' , ; ` | : Remove collected futures ... [05:57:26.561] | : . ' , ; ` | : . Indices of futures to drop: [n=1] '1' [05:57:26.562] | : . ' , ; ` | : Remove collected futures ... done [05:57:26.562] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'collect-first', earlySignal = 1) ... done [05:57:26.562] | : . ' , ; ` | Early signaling of 1 future candidates ... [05:57:26.562] | : . ' , ; ` | Number of futures with early signaling requested: 0 [05:57:26.563] | : . ' , ; ` | Early signaling of 1 future candidates ... done [05:57:26.563] | : . ' , ; ` | Number of registered futures: 1 [05:57:26.563] | : . ' , ; ` Polling for a free worker ... done [05:57:26.564] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:26.564] | : . ' , ; ` | Listing all futures [05:57:26.564] | : . ' , ; ` | Number of registered futures: 0 [05:57:26.565] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:26.565] | : . ' , ; ` Total time: 0.113447904586792 [05:57:26.565] | : . ' , ; requestNode() ... done [05:57:26.565] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:26.566] | : . ' , ; ` Listing all futures [05:57:26.566] | : . ' , ; ` Number of registered futures: 0 [05:57:26.566] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:26.567] | : . ' , ; avail: [n=1] '1' [05:57:26.567] | : . ' , ; Index of first available worker: 1 [05:57:26.567] | : . ' , ; Validate that the worker is functional ... [05:57:26.569] | : . ' , ; ` Worker is functional [05:57:26.569] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:26.569] | : . ' , ; ` | Listing all futures [05:57:26.570] | : . ' , ; ` | Number of registered futures: 0 [05:57:26.570] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:26.570] | : . ' , ; Validate that the worker is functional ... done [05:57:26.571] | : . ' , requestWorker() ... done [05:57:26.571] | : . ' , cluster node index: 1 [05:57:26.571] | : . ' launchFuture() for ClusterFutureBackend ... done [05:57:26.572] | : . ' eraseGlobalEnvironment() ... [05:57:26.572] | : . ' eraseGlobalEnvironment() ... done [05:57:26.573] | : . ' launchFuture() ... [05:57:26.573] | : . ' , cluster node index: 1 [05:57:26.573] | : . ' , getFutureData() ... [05:57:26.573] | : . ' , ; getFutureCore() ... [05:57:26.574] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:26.574] | : . ' , ; getFutureCore() ... done [05:57:26.574] | : . ' , ; getFutureCapture() ... [05:57:26.575] | : . ' , ; getFutureCapture() ... done [05:57:26.575] | : . ' , ; getFutureContext() ... [05:57:26.575] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.576] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:26.576] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:26.576] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:26.577] | : . ' , ; getFutureContext() ... done [05:57:26.577] | : . ' , getFutureData() ... done [05:57:26.578] | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... [05:57:26.578] | : . ' , ; Appended future to position #1 [05:57:26.578] | : . ' , ; Number of registered futures: 1 [05:57:26.579] | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... done [05:57:26.579] | : . ' launchFuture() ... done [05:57:26.579] | : . ' ClusterFuture started [05:57:26.580] | : . Launching futures ... done [05:57:26.580] | : Using ClusterFutureBackend ... done [05:57:26.580] | : Future launched: 'ClusterFuture', 'MultiprocessFuture', 'Future' [05:57:26.580] | run() for 'Future' () ... done [05:57:26.581] future(..., label = NULL) ... done [05:57:26.582] value() for list ... [05:57:26.582] | recursive: 0 [05:57:26.583] | reduce: FALSE [05:57:26.583] | length: 2 [05:57:26.584] | Number of remaining objects: 2 [05:57:26.584] | checking value #1: [05:57:26.584] | 'obj' is ClusterFuture [05:57:26.585] | ClusterFuture #1 [05:57:26.585] | signalConditionsASAP(ClusterFuture, pos=1) ... [05:57:26.585] | : nx: 2 [05:57:26.585] | : relay: TRUE [05:57:26.586] | : stdout: TRUE [05:57:26.586] | : signal: TRUE [05:57:26.586] | : resignal: FALSE [05:57:26.586] | : force: TRUE [05:57:26.587] | : relayed: [n=2] FALSE, FALSE [05:57:26.587] | : queued futures: [n=2] FALSE, FALSE [05:57:26.587] | : until=1 [05:57:26.587] | : relaying element #1 [05:57:26.588] | : value() for ClusterFuture () ... [05:57:26.588] | : . result() for ClusterFuture ... [05:57:26.588] | : . ' result already collected: FutureResult [05:57:26.589] | : . result() for ClusterFuture ... done [05:57:26.589] | : . result() for ClusterFuture ... [05:57:26.589] | : . ' result already collected: FutureResult [05:57:26.590] | : . result() for ClusterFuture ... done [05:57:26.590] | : . signalConditions() ... [05:57:26.590] | : . ' include = 'immediateCondition' [05:57:26.591] | : . ' exclude = [05:57:26.591] | : . ' resignal = FALSE [05:57:26.591] | : . ' Number of conditions: 0 [05:57:26.591] | : . ' int 0 [05:57:26.592] | : . signalConditions() ... done [05:57:26.593] | : . relay stdout ... [05:57:26.593] | : . relay stdout ... done [05:57:26.593] | : . check for misuse ... [05:57:26.594] | : . check for misuse ... done [05:57:26.594] | : value() for ClusterFuture () ... done [05:57:26.594] | : result() for ClusterFuture ... [05:57:26.595] | : . result already collected: FutureResult [05:57:26.595] | : result() for ClusterFuture ... done [05:57:26.595] | : signalConditions() ... [05:57:26.596] | : . include = 'immediateCondition' [05:57:26.596] | : . exclude = [05:57:26.596] | : . resignal = FALSE [05:57:26.596] | : . Number of conditions: 0 [05:57:26.597] | : . int 0 [05:57:26.598] | : signalConditions() ... done [05:57:26.598] | : result() for ClusterFuture ... [05:57:26.598] | : . result already collected: FutureResult [05:57:26.599] | : result() for ClusterFuture ... done [05:57:26.599] | : signalConditions() ... [05:57:26.599] | : . include = 'condition' [05:57:26.599] | : . exclude = 'error', 'immediateCondition' [05:57:26.600] | : . resignal = TRUE [05:57:26.600] | : . Number of conditions: 0 [05:57:26.600] | : . int 0 [05:57:26.601] | : signalConditions() ... done [05:57:26.602] | : relayed: [n=2] TRUE, FALSE [05:57:26.602] | : queued futures: [n=2] TRUE, FALSE [05:57:26.602] | signalConditionsASAP(ClusterFuture, pos=1) ... done [05:57:26.602] | value(, ...) ... [05:57:26.603] | value(, ...) ... done [05:57:26.603] | value() for ClusterFuture () ... [05:57:26.603] | : result() for ClusterFuture ... [05:57:26.604] | : . result already collected: FutureResult [05:57:26.604] | : result() for ClusterFuture ... done [05:57:26.604] | : result() for ClusterFuture ... [05:57:26.605] | : . result already collected: FutureResult [05:57:26.605] | : result() for ClusterFuture ... done [05:57:26.605] | : signalConditions() ... [05:57:26.605] | : . include = 'immediateCondition' [05:57:26.606] | : . exclude = [05:57:26.606] | : . resignal = FALSE [05:57:26.606] | : . Number of conditions: 0 [05:57:26.607] | : . int 0 [05:57:26.607] | : signalConditions() ... done [05:57:26.608] | : check for misuse ... [05:57:26.608] | : check for misuse ... done [05:57:26.608] | value() for ClusterFuture () ... done [05:57:26.609] | value: [05:57:26.609] | signalConditionsASAP(ClusterFuture, pos=1) ... [05:57:26.609] | : nx: 2 [05:57:26.610] | : relay: TRUE [05:57:26.610] | : stdout: TRUE [05:57:26.610] | : signal: TRUE [05:57:26.610] | : resignal: FALSE [05:57:26.611] | : force: TRUE [05:57:26.611] | : relayed: [n=2] TRUE, FALSE [05:57:26.611] | : queued futures: [n=2] TRUE, FALSE [05:57:26.611] | : until=2 [05:57:26.612] | : relaying element #2 [05:57:26.612] | : relayed: [n=2] TRUE, FALSE [05:57:26.612] | : queued futures: [n=2] TRUE, FALSE [05:57:26.613] | signalConditionsASAP(ClusterFuture, pos=1) ... done [05:57:26.613] | resolve() for ClusterFuture ... [05:57:26.613] | resolve() for ClusterFuture ... done [05:57:26.614] | length: 1 (resolved future 1) [05:57:26.614] value() for list ... done [05:57:26.614] checking value #2: [05:57:26.615] 'obj' is ClusterFuture [05:57:26.615] resolved() for ClusterFuture () ... [05:57:26.616] | Cluster node socket connection: index=4, id=139 [05:57:26.616] | assertValidConnection() ... [05:57:26.616] | : cluster node index: 1 [05:57:26.617] | assertValidConnection() ... done [05:57:26.617] | receiveMessageFromWorker() for ClusterFuture ... [05:57:26.618] | : cluster node index: 1 [05:57:26.618] | : [1] TRUE [05:57:26.619] | : received data: [05:57:26.619] | : List of 5 [05:57:26.619] | : $ type : chr "VALUE" [05:57:26.619] | : $ value :List of 16 [05:57:26.619] | : ..$ value : int 2 [05:57:26.619] | : ..$ visible : logi TRUE [05:57:26.619] | : ..$ stdout : chr "" [05:57:26.619] | : ..$ conditions : list() [05:57:26.619] | : ..$ rng : logi FALSE [05:57:26.619] | : ..$ seed : NULL [05:57:26.619] | : ..$ misuseGlobalEnv : NULL [05:57:26.619] | : ..$ misuseConnections :List of 3 [05:57:26.619] | : .. ..$ added : NULL [05:57:26.619] | : .. ..$ removed : NULL [05:57:26.619] | : .. ..$ replaced: NULL [05:57:26.619] | : ..$ misuseDevices : NULL [05:57:26.619] | : ..$ misuseDefaultDevice: list() [05:57:26.619] | : ..$ started : POSIXct[1:1], format: "2025-06-05 05:57:26" [05:57:26.619] | : ..$ finished : POSIXct[1:1], format: "2025-06-05 05:57:26" [05:57:26.619] | : ..$ uuid : chr [1:2] "e6fc8766d87d810603f2d8674725d8b6" "2" [05:57:26.619] | : ..$ session_uuid : chr "a85e9e29a0f0e4ec00dc76a60ea26de1" [05:57:26.619] | : .. ..- attr(*, "source")=List of 5 [05:57:26.619] | : .. .. ..$ host : Named chr "CRANWIN3" [05:57:26.619] | : .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [05:57:26.619] | : .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:26.619] | : .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:26.619] | : .. .. ..$ pid : int 163468 [05:57:26.619] | : .. .. ..$ time : POSIXct[1:1], format: "2025-06-05 05:57:26" [05:57:26.619] | : .. .. ..$ random: int 2147483647 [05:57:26.619] | : ..$ r_info :List of 4 [05:57:26.619] | : .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [05:57:26.619] | : .. .. ..$ : int [1:3] 4 6 0 [05:57:26.619] | : .. ..$ os : chr "windows" [05:57:26.619] | : .. ..$ os_name : chr "Windows" [05:57:26.619] | : .. ..$ captures_utf8: logi TRUE [05:57:26.619] | : ..$ version : chr "1.8" [05:57:26.619] | : ..- attr(*, "class")= chr "FutureResult" [05:57:26.619] | : $ success: logi TRUE [05:57:26.619] | : $ time : 'proc_time' Named num [1:5] 0 0 0 NA NA [05:57:26.619] | : ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [05:57:26.619] | : $ tag : NULL [05:57:26.644] | : Received FutureResult [05:57:26.644] | : FutureResult: [05:57:26.644] | : value: 'integer' [05:57:26.644] | : visible: TRUE [05:57:26.644] | : stdout: character [05:57:26.644] | : conditions: [n = 0] [05:57:26.644] | : RNG used: FALSE [05:57:26.644] | : duration: 0.004775047 secs (started 2025-06-05 05:57:26.578529) [05:57:26.644] | : version: 1.8 [05:57:26.645] | : FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... [05:57:26.646] | : . Removed future from position #1 [05:57:26.646] | : . Number of registered futures: 0 [05:57:26.646] | : FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... done [05:57:26.647] | : Erased future from future backend [05:57:26.647] | : result() for ClusterFuture ... [05:57:26.647] | : . result already collected: FutureResult [05:57:26.647] | : result() for ClusterFuture ... done [05:57:26.648] | : signalConditions() ... [05:57:26.648] | : . include = 'immediateCondition' [05:57:26.648] | : . exclude = [05:57:26.649] | : . resignal = FALSE [05:57:26.649] | : . Number of conditions: 0 [05:57:26.649] | : . int 0 [05:57:26.650] | : signalConditions() ... done [05:57:26.650] | receiveMessageFromWorker() for ClusterFuture ... done [05:57:26.651] | receiveMessageFromWorker() returned object of class FutureResult; resolved [05:57:26.651] resolved() for ClusterFuture () ... done [05:57:26.651] assertFutureResult() ... [05:57:26.651] | Future uuid: e6fc8766d87d810603f2d8674725d8b6[05:57:26.651] | Future uuid: 2 [05:57:26.652] | identical; success [05:57:26.652] assertFutureResult() ... done [05:57:26.652] ClusterFuture #2 [05:57:26.653] signalConditionsASAP(ClusterFuture, pos=2) ... [05:57:26.653] | nx: 2 [05:57:26.653] | relay: TRUE [05:57:26.653] | stdout: TRUE [05:57:26.654] | signal: TRUE [05:57:26.654] | resignal: FALSE [05:57:26.654] | force: TRUE [05:57:26.654] | relayed: [n=2] TRUE, FALSE [05:57:26.655] | queued futures: [n=2] TRUE, FALSE [05:57:26.655] | until=2 [05:57:26.655] | relaying element #2 [05:57:26.656] | value() for ClusterFuture () ... [05:57:26.656] | : result() for ClusterFuture ... [05:57:26.656] | : . result already collected: FutureResult [05:57:26.656] | : result() for ClusterFuture ... done [05:57:26.657] | : result() for ClusterFuture ... [05:57:26.657] | : . result already collected: FutureResult [05:57:26.657] | : result() for ClusterFuture ... done [05:57:26.658] | : signalConditions() ... [05:57:26.658] | : . include = 'immediateCondition' [05:57:26.658] | : . exclude = [05:57:26.659] | : . resignal = FALSE [05:57:26.659] | : . Number of conditions: 0 [05:57:26.659] | : . int 0 [05:57:26.660] | : signalConditions() ... done [05:57:26.660] | : relay stdout ... [05:57:26.661] | : relay stdout ... done [05:57:26.661] | : check for misuse ... [05:57:26.661] | : check for misuse ... done [05:57:26.662] | value() for ClusterFuture () ... done [05:57:26.662] | result() for ClusterFuture ... [05:57:26.662] | : result already collected: FutureResult [05:57:26.663] | result() for ClusterFuture ... done [05:57:26.663] | signalConditions() ... [05:57:26.663] | : include = 'immediateCondition' [05:57:26.663] | : exclude = [05:57:26.664] | : resignal = FALSE [05:57:26.664] | : Number of conditions: 0 [05:57:26.664] | : int 0 [05:57:26.665] | signalConditions() ... done [05:57:26.666] | result() for ClusterFuture ... [05:57:26.666] | : result already collected: FutureResult [05:57:26.666] | result() for ClusterFuture ... done [05:57:26.666] | signalConditions() ... [05:57:26.667] | : include = 'condition' [05:57:26.667] | : exclude = 'error', 'immediateCondition' [05:57:26.667] | : resignal = TRUE [05:57:26.668] | : Number of conditions: 0 [05:57:26.668] | : int 0 [05:57:26.669] | signalConditions() ... done [05:57:26.669] | relayed: [n=2] TRUE, TRUE [05:57:26.669] | queued futures: [n=2] TRUE, TRUE [05:57:26.670] signalConditionsASAP(ClusterFuture, pos=2) ... done [05:57:26.670] value(, ...) ... [05:57:26.670] value(, ...) ... done [05:57:26.670] value() for ClusterFuture () ... [05:57:26.671] | result() for ClusterFuture ... [05:57:26.671] | : result already collected: FutureResult [05:57:26.671] | result() for ClusterFuture ... done [05:57:26.672] | result() for ClusterFuture ... [05:57:26.672] | : result already collected: FutureResult [05:57:26.672] | result() for ClusterFuture ... done [05:57:26.673] | signalConditions() ... [05:57:26.673] | : include = 'immediateCondition' [05:57:26.673] | : exclude = [05:57:26.673] | : resignal = FALSE [05:57:26.674] | : Number of conditions: 0 [05:57:26.674] | : int 0 [05:57:26.675] | signalConditions() ... done [05:57:26.675] | check for misuse ... [05:57:26.676] | check for misuse ... done [05:57:26.676] value() for ClusterFuture () ... done [05:57:26.676] value: [05:57:26.676] signalConditionsASAP(ClusterFuture, pos=2) ... [05:57:26.677] | nx: 2 [05:57:26.677] | relay: TRUE [05:57:26.677] | stdout: TRUE [05:57:26.677] | signal: TRUE [05:57:26.678] | resignal: FALSE [05:57:26.678] | force: TRUE [05:57:26.678] | relayed: [n=2] TRUE, TRUE [05:57:26.679] | queued futures: [n=2] TRUE, TRUE [05:57:26.679] | until=2 [05:57:26.679] | relayed: [n=2] TRUE, TRUE [05:57:26.679] | queued futures: [n=2] TRUE, TRUE [05:57:26.680] signalConditionsASAP(ClusterFuture, pos=2) ... done [05:57:26.680] resolve() for ClusterFuture ... [05:57:26.680] resolve() for ClusterFuture ... done [05:57:26.681] length: 0 (resolved future 2) [05:57:26.681] Relaying remaining futures ... [05:57:26.681] | signalConditionsASAP(NULL, pos=0) ... [05:57:26.682] | : nx: 2 [05:57:26.682] | : relay: TRUE [05:57:26.682] | : stdout: TRUE [05:57:26.682] | : signal: TRUE [05:57:26.683] | : resignal: FALSE [05:57:26.683] | : force: TRUE [05:57:26.683] | : relayed: [n=2] TRUE, TRUE [05:57:26.684] | : queued futures: [n=2] TRUE, TRUE - flush all [05:57:26.684] | : relayed: [n=2] TRUE, TRUE [05:57:26.684] | : queued futures: [n=2] TRUE, TRUE [05:57:26.685] | signalConditionsASAP(NULL, pos=0) ... done [05:57:26.685] Relaying remaining futures ... done Iteration #2 [05:57:26.950] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:26.951] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... [05:57:26.952] | : all.equal() for FutureStrategyList ... [05:57:26.952] | : . New stack: [05:57:26.953] | : . List of 1 [05:57:26.953] | : . $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.953] | : . envir = parent.frame()) [05:57:26.953] | : . ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.953] | : . ..- attr(*, "init")= logi TRUE [05:57:26.953] | : . ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.953] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.953] | : . .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.953] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.953] | : . ..- attr(*, "tweaks")=List of 1 [05:57:26.953] | : . .. ..$ workers:List of 1 [05:57:26.953] | : . .. .. ..$ :List of 3 [05:57:26.953] | : . .. .. .. ..$ con : 'sockconn' int 4 [05:57:26.953] | : . .. .. .. .. ..- attr(*, "conn_id")= [05:57:26.953] | : . .. .. .. ..$ host: chr "localhost" [05:57:26.953] | : . .. .. .. ..$ rank: num 0 [05:57:26.953] | : . .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.953] | : . .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.953] | : . ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.953] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:26.968] | : . Old stack: [05:57:26.969] | : . List of 1 [05:57:26.969] | : . $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.969] | : . envir = parent.frame()) [05:57:26.969] | : . ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.969] | : . ..- attr(*, "init")= chr "done" [05:57:26.969] | : . ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.969] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.969] | : . .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.969] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.969] | : . ..- attr(*, "tweaks")=List of 1 [05:57:26.969] | : . .. ..$ workers:List of 1 [05:57:26.969] | : . .. .. ..$ :List of 3 [05:57:26.969] | : . .. .. .. ..$ con : 'sockconn' int 4 [05:57:26.969] | : . .. .. .. .. ..- attr(*, "conn_id")= [05:57:26.969] | : . .. .. .. ..$ host: chr "localhost" [05:57:26.969] | : . .. .. .. ..$ rank: num 0 [05:57:26.969] | : . .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.969] | : . .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.969] | : . ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.969] | : . ..- attr(*, "backend")=Classes 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment' [05:57:26.969] | : . .. ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.969] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.969] | : . .. .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.969] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:26.985] | : . Not identical [05:57:26.985] | : . all.equal() for future ... [05:57:26.986] | : . ' List of 2 [05:57:26.986] | : . ' $ target :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.986] | : . ' envir = parent.frame()) [05:57:26.986] | : . ' ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.986] | : . ' ..- attr(*, "init")= logi TRUE [05:57:26.986] | : . ' ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.986] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.986] | : . ' .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.986] | : . ' ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.986] | : . ' ..- attr(*, "tweaks")=List of 1 [05:57:26.986] | : . ' .. ..$ workers:List of 1 [05:57:26.986] | : . ' .. .. ..$ :List of 3 [05:57:26.986] | : . ' .. .. .. ..$ con : 'sockconn' int 4 [05:57:26.986] | : . ' .. .. .. .. ..- attr(*, "conn_id")= [05:57:26.986] | : . ' .. .. .. ..$ host: chr "localhost" [05:57:26.986] | : . ' .. .. .. ..$ rank: num 0 [05:57:26.986] | : . ' .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.986] | : . ' .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.986] | : . ' ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.986] | : . ' $ current:function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:26.986] | : . ' envir = parent.frame()) [05:57:26.986] | : . ' ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:26.986] | : . ' ..- attr(*, "init")= chr "done" [05:57:26.986] | : . ' ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.986] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.986] | : . ' .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.986] | : . ' ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:26.986] | : . ' ..- attr(*, "tweaks")=List of 1 [05:57:26.986] | : . ' .. ..$ workers:List of 1 [05:57:26.986] | : . ' .. .. ..$ :List of 3 [05:57:26.986] | : . ' .. .. .. ..$ con : 'sockconn' int 4 [05:57:26.986] | : . ' .. .. .. .. ..- attr(*, "conn_id")= [05:57:26.986] | : . ' .. .. .. ..$ host: chr "localhost" [05:57:26.986] | : . ' .. .. .. ..$ rank: num 0 [05:57:26.986] | : . ' .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:26.986] | : . ' .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:26.986] | : . ' ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:26.986] | : . ' ..- attr(*, "backend")=Classes 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment' [05:57:26.986] | : . ' .. ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:26.986] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:26.986] | : . ' .. .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.011] | : . ' Formals differ [05:57:27.011] | : . all.equal() for future ... done [05:57:27.012] | : . Future strategies differ at level 1 [05:57:27.012] | : all.equal() for FutureStrategyList ... done [05:57:27.012] | : plan(): Setting new future backend stack: [05:57:27.012] | : List of future strategies: [05:57:27.012] | : 1. cluster: [05:57:27.012] | : - args: function (..., workers = "", envir = parent.frame()) [05:57:27.012] | : - tweaked: TRUE [05:57:27.012] | : - call: plan(cluster, workers = cl) [05:57:27.014] | : List of 1 [05:57:27.014] | : $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.014] | : envir = parent.frame()) [05:57:27.014] | : ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.014] | : ..- attr(*, "init")= logi TRUE [05:57:27.014] | : ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.014] | : earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.014] | : .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.014] | : ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.014] | : ..- attr(*, "tweaks")=List of 1 [05:57:27.014] | : .. ..$ workers:List of 1 [05:57:27.014] | : .. .. ..$ :List of 3 [05:57:27.014] | : .. .. .. ..$ con : 'sockconn' int 4 [05:57:27.014] | : .. .. .. .. ..- attr(*, "conn_id")= [05:57:27.014] | : .. .. .. ..$ host: chr "localhost" [05:57:27.014] | : .. .. .. ..$ rank: num 0 [05:57:27.014] | : .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.014] | : .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.014] | : ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.014] | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:27.024] | : plan(): plan_cleanup('tweaked', 'cluster', 'multiprocess', 'future', 'function', cleanup = NA) ... [05:57:27.024] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.025] | : . ' Getting current ("next") strategy: 'FutureStrategy', 'tweaked', 'cluster', 'multiprocess', 'future', 'function' [05:57:27.025] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.025] | : . stopWorkers() for ClusterFutureBackend ... [05:57:27.026] | : . ' Interrupt active futures ... [05:57:27.027] | : . ' , Number of futures: 0 [05:57:27.027] | : . ' Interrupt active futures ... done [05:57:27.027] | : . ' Clear future registry ... [05:57:27.028] | : . ' Clear future registry ... done [05:57:27.029] | : . ' Stop cluster workers ... [05:57:27.029] | : . ' , Stopping existing cluster ... [05:57:27.029] | : . ' , ; No pre-existing cluster. Skipping [05:57:27.029] | : . ' , Stopping existing cluster ... done [05:57:27.030] | : . ' Stop cluster workers ... done [05:57:27.030] | : . stopWorkers() for ClusterFutureBackend ... done [05:57:27.030] | : . Legacy shutdown of cluster workers ... [05:57:27.031] | : . ' Stopping existing cluster ... [05:57:27.031] | : . ' , No pre-existing cluster. Skipping [05:57:27.031] | : . ' Stopping existing cluster ... done [05:57:27.031] | : . Legacy shutdown of cluster workers ... done [05:57:27.032] | : plan(): plan_cleanup('tweaked', 'cluster', 'multiprocess', 'future', 'function', cleanup = NA) ... done [05:57:27.032] | : plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... [05:57:27.032] | : . function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.032] | : . envir = parent.frame()) [05:57:27.032] | : . - attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.032] | : . - attr(*, "init")= logi TRUE [05:57:27.032] | : . - attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.032] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.032] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.032] | : . - attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.032] | : . - attr(*, "tweaks")=List of 1 [05:57:27.032] | : . ..$ workers:List of 1 [05:57:27.032] | : . .. ..$ :List of 3 [05:57:27.032] | : . .. .. ..$ con : 'sockconn' int 4 [05:57:27.032] | : . .. .. .. ..- attr(*, "conn_id")= [05:57:27.032] | : . .. .. ..$ host: chr "localhost" [05:57:27.032] | : . .. .. ..$ rank: num 0 [05:57:27.032] | : . .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.032] | : . .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.032] | : . - attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.041] | : . init: TRUE [05:57:27.041] | : . makeFutureBackend() ... [05:57:27.042] | : . ' Backend function: <'NULL'> [05:57:27.042] | : . ' Evaluator tweak arguments: [n=1] [05:57:27.042] | : . ' List of 1 [05:57:27.042] | : . ' $ workers:List of 1 [05:57:27.042] | : . ' ..$ :List of 3 [05:57:27.042] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:27.042] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:27.042] | : . ' .. ..$ host: chr "localhost" [05:57:27.042] | : . ' .. ..$ rank: num 0 [05:57:27.042] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.042] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.047] | : . ' Evaluator formal arguments: [n=1] [05:57:27.047] | : . ' List of 1 [05:57:27.047] | : . ' $ workers:List of 1 [05:57:27.047] | : . ' ..$ :List of 3 [05:57:27.047] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:27.047] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:27.047] | : . ' .. ..$ host: chr "localhost" [05:57:27.047] | : . ' .. ..$ rank: num 0 [05:57:27.047] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.047] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.052] | : . ' Backend factory arguments: [n=1] [05:57:27.052] | : . ' Dotted pair list of 1 [05:57:27.052] | : . ' $ workers:List of 1 [05:57:27.052] | : . ' ..$ :List of 3 [05:57:27.052] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:27.052] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:27.052] | : . ' .. ..$ host: chr "localhost" [05:57:27.052] | : . ' .. ..$ rank: num 0 [05:57:27.052] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.052] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.101] | : . ' ClusterFutureBackend(..., persistent = FALSE, gc = TRUE, earlySignal = TRUE) ... [05:57:27.102] | : . ' , Stopping existing cluster ... [05:57:27.102] | : . ' , ; No pre-existing cluster. Skipping [05:57:27.102] | : . ' , Stopping existing cluster ... done [05:57:27.102] | : . ' , Number of workers: 1 [05:57:27.103] | : . ' , Generated workers UUID [05:57:27.103] | : . ' , Workers UUID: '37e5752128e4483a3ce8b7fda2d6c13d' [05:57:27.103] | : . ' ClusterFutureBackend(..., persistent = FALSE, gc = TRUE, earlySignal = TRUE) ... done [05:57:27.104] | : . ' Backend: <'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment'> [05:57:27.104] | : . makeFutureBackend() ... done [05:57:27.104] | : plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... done [05:57:27.104] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.105] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.105] | : plan(): nbrOfWorkers() = 1 [05:57:27.105] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done [05:57:27.105] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.106] future(..., label = NULL) ... [05:57:27.106] | lazy: FALSE [05:57:27.106] | stdout: TRUE [05:57:27.106] | conditions: [n=1] 'condition' [05:57:27.106] | gc: FALSE [05:57:27.107] | earlySignal: FALSE [05:57:27.107] | getGlobalsAndPackages() ... [05:57:27.107] | : Searching for globals ... [05:57:27.114] | : . globals found: [3] '[[', 'X', 'i' [05:57:27.114] | : Searching for globals ... done [05:57:27.114] | : Resolving globals: FALSE [05:57:27.115] | : Search for packages associated with the globals ... [05:57:27.115] | : . Packages associated with globals: [1] 'base' [05:57:27.116] | : . Packages: [1] 'base' [05:57:27.116] | : Search for packages associated with the globals ... done [05:57:27.116] | : Packages after dropping 'base': [0] [05:57:27.117] | : globals: [2] 'X', 'i' [05:57:27.117] | : packages: [0] [05:57:27.117] | getGlobalsAndPackages() ... done [05:57:27.118] | run() for 'Future' () ... [05:57:27.118] | : state: 'created' [05:57:27.118] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.118] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.119] | : Using ClusterFutureBackend ... [05:57:27.119] | : . Number of futures since start: 0 (0 created, 0 launched, 0 finished) [05:57:27.119] | : . Launching futures ... [05:57:27.120] | : . ' launchFuture() for ClusterFutureBackend ... [05:57:27.120] | : . ' , Workers: [n=1] [05:57:27.120] | : . ' , socket cluster with 1 nodes on host 'localhost' [05:57:27.121] | : . ' , FutureRegistry: 'workers-37e5752128e4483a3ce8b7fda2d6c13d' [05:57:27.121] | : . ' , requestWorker() ... [05:57:27.121] | : . ' , ; requestNode() ... [05:57:27.122] | : . ' , ; ` Number of workers: 1 [05:57:27.122] | : . ' , ; ` Polling for a free worker ... [05:57:27.122] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.122] | : . ' , ; ` | : Listing all futures [05:57:27.123] | : . ' , ; ` | : Number of registered futures: 0 [05:57:27.126] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.126] | : . ' , ; ` | Total time: 0 [05:57:27.126] | : . ' , ; ` Polling for a free worker ... done [05:57:27.126] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.127] | : . ' , ; ` | Listing all futures [05:57:27.127] | : . ' , ; ` | Number of registered futures: 0 [05:57:27.127] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.127] | : . ' , ; ` avail: [n=1] '1' [05:57:27.128] | : . ' , ; ` Index of first available worker: 1 [05:57:27.128] | : . ' , ; ` Validate that the worker is functional ... [05:57:27.253] | : . ' , ; ` | Worker is functional [05:57:27.253] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.253] | : . ' , ; ` | : Listing all futures [05:57:27.254] | : . ' , ; ` | : Number of registered futures: 0 [05:57:27.254] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.254] | : . ' , ; ` Validate that the worker is functional ... done [05:57:27.254] | : . ' , ; requestNode() ... done [05:57:27.255] | : . ' , ; cluster node index: 1 [05:57:27.255] | : . ' , requestWorker() ... done [05:57:27.255] | : . ' , eraseGlobalEnvironment() ... [05:57:27.256] | : . ' , eraseGlobalEnvironment() ... done [05:57:27.256] | : . ' , launchFuture() ... [05:57:27.257] | : . ' , ; cluster node index: 1 [05:57:27.257] | : . ' , ; getFutureData() ... [05:57:27.257] | : . ' , ; ` getFutureCore() ... [05:57:27.257] | : . ' , ; ` | Packages needed by the future expression (n = 0): [05:57:27.258] | : . ' , ; ` getFutureCore() ... done [05:57:27.258] | : . ' , ; ` getFutureCapture() ... [05:57:27.258] | : . ' , ; ` getFutureCapture() ... done [05:57:27.258] | : . ' , ; ` getFutureContext() ... [05:57:27.259] | : . ' , ; ` | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.259] | : . ' , ; ` | : Getting stack without first backend: [n=0] [05:57:27.259] | : . ' , ; ` | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.259] | : . ' , ; ` | Packages needed by future backend (n = 0): [05:57:27.260] | : . ' , ; ` getFutureContext() ... done [05:57:27.260] | : . ' , ; getFutureData() ... done [05:57:27.261] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... [05:57:27.261] | : . ' , ; ` Appended future to position #1 [05:57:27.262] | : . ' , ; ` Number of registered futures: 1 [05:57:27.262] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... done [05:57:27.262] | : . ' , launchFuture() ... done [05:57:27.262] | : . ' , ClusterFuture started [05:57:27.263] | : . ' launchFuture() for ClusterFutureBackend ... done [05:57:27.263] | : . Launching futures ... done [05:57:27.263] | : . Future launched: 'ClusterFuture', 'MultiprocessFuture', 'Future' [05:57:27.264] | : Using ClusterFutureBackend ... done [05:57:27.264] | run() for 'Future' () ... done [05:57:27.264] future(..., label = NULL) ... done [05:57:27.264] future(..., label = NULL) ... [05:57:27.265] | lazy: FALSE [05:57:27.265] | stdout: TRUE [05:57:27.265] | conditions: [n=1] 'condition' [05:57:27.265] | gc: FALSE [05:57:27.266] | earlySignal: FALSE [05:57:27.266] | getGlobalsAndPackages() ... [05:57:27.266] | : Searching for globals ... [05:57:27.274] | : . globals found: [3] '[[', 'X', 'i' [05:57:27.274] | : Searching for globals ... done [05:57:27.274] | : Resolving globals: FALSE [05:57:27.275] | : Search for packages associated with the globals ... [05:57:27.275] | : . Packages associated with globals: [1] 'base' [05:57:27.276] | : . Packages: [1] 'base' [05:57:27.276] | : Search for packages associated with the globals ... done [05:57:27.276] | : Packages after dropping 'base': [0] [05:57:27.276] | : globals: [2] 'X', 'i' [05:57:27.277] | : packages: [0] [05:57:27.277] | getGlobalsAndPackages() ... done [05:57:27.277] | run() for 'Future' () ... [05:57:27.277] | : state: 'created' [05:57:27.278] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.278] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.278] | : Using ClusterFutureBackend ... [05:57:27.278] | : . Number of futures since start: 1 (1 created, 1 launched, 0 finished) [05:57:27.278] | : . Launching futures ... [05:57:27.279] | : . ' launchFuture() for ClusterFutureBackend ... [05:57:27.279] | : . ' , Workers: [n=1] [05:57:27.279] | : . ' , socket cluster with 1 nodes on host 'localhost' [05:57:27.279] | : . ' , FutureRegistry: 'workers-37e5752128e4483a3ce8b7fda2d6c13d' [05:57:27.280] | : . ' , requestWorker() ... [05:57:27.280] | : . ' , ; requestNode() ... [05:57:27.280] | : . ' , ; ` Number of workers: 1 [05:57:27.280] | : . ' , ; ` Polling for a free worker ... [05:57:27.280] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.280] | : . ' , ; ` | : Listing all futures [05:57:27.281] | : . ' , ; ` | : Number of registered futures: 1 [05:57:27.281] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.281] | : . ' , ; ` | Poll #1 (0): usedNodes() = 1, workers = 1 [05:57:27.292] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'collect-first', earlySignal = 1) ... [05:57:27.334] | : . ' , ; ` | : collectValues('workers-37e5752128e4483a3ce8b7fda2d6c13d', firstOnly = TRUE) ... [05:57:27.335] | : . ' , ; ` | : . resolved() for ClusterFuture () ... [05:57:27.335] | : . ' , ; ` | : . ' Cluster node socket connection: index=4, id=179 [05:57:27.336] | : . ' , ; ` | : . ' assertValidConnection() ... [05:57:27.336] | : . ' , ; ` | : . ' , cluster node index: 1 [05:57:27.336] | : . ' , ; ` | : . ' assertValidConnection() ... done [05:57:27.346] | : . ' , ; ` | : . ' receiveMessageFromWorker() for ClusterFuture ... [05:57:27.346] | : . ' , ; ` | : . ' , cluster node index: 1 [05:57:27.346] | : . ' , ; ` | : . ' , [1] TRUE [05:57:27.347] | : . ' , ; ` | : . ' , received data: [05:57:27.347] | : . ' , ; ` | : . ' , List of 5 [05:57:27.347] | : . ' , ; ` | : . ' , $ type : chr "VALUE" [05:57:27.347] | : . ' , ; ` | : . ' , $ value :List of 16 [05:57:27.347] | : . ' , ; ` | : . ' , ..$ value : int 1 [05:57:27.347] | : . ' , ; ` | : . ' , ..$ visible : logi TRUE [05:57:27.347] | : . ' , ; ` | : . ' , ..$ stdout : chr "" [05:57:27.347] | : . ' , ; ` | : . ' , ..$ conditions : list() [05:57:27.347] | : . ' , ; ` | : . ' , ..$ rng : logi FALSE [05:57:27.347] | : . ' , ; ` | : . ' , ..$ seed : NULL [05:57:27.347] | : . ' , ; ` | : . ' , ..$ misuseGlobalEnv : NULL [05:57:27.347] | : . ' , ; ` | : . ' , ..$ misuseConnections :List of 3 [05:57:27.347] | : . ' , ; ` | : . ' , .. ..$ added : NULL [05:57:27.347] | : . ' , ; ` | : . ' , .. ..$ removed : NULL [05:57:27.347] | : . ' , ; ` | : . ' , .. ..$ replaced: NULL [05:57:27.347] | : . ' , ; ` | : . ' , ..$ misuseDevices : NULL [05:57:27.347] | : . ' , ; ` | : . ' , ..$ misuseDefaultDevice: list() [05:57:27.347] | : . ' , ; ` | : . ' , ..$ started : POSIXct[1:1], format: "2025-06-05 05:57:27" [05:57:27.347] | : . ' , ; ` | : . ' , ..$ finished : POSIXct[1:1], format: "2025-06-05 05:57:27" [05:57:27.347] | : . ' , ; ` | : . ' , ..$ uuid : chr [1:2] "e6fc8766d87d810603f2d8674725d8b6" "3" [05:57:27.347] | : . ' , ; ` | : . ' , ..$ session_uuid : chr "2117cfd314f1fb5440e35b1600f029f9" [05:57:27.347] | : . ' , ; ` | : . ' , .. ..- attr(*, "source")=List of 5 [05:57:27.347] | : . ' , ; ` | : . ' , .. .. ..$ host : Named chr "CRANWIN3" [05:57:27.347] | : . ' , ; ` | : . ' , .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [05:57:27.347] | : . ' , ; ` | : . ' , .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:27.347] | : . ' , ; ` | : . ' , .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:27.347] | : . ' , ; ` | : . ' , .. .. ..$ pid : int 76792 [05:57:27.347] | : . ' , ; ` | : . ' , .. .. ..$ time : POSIXct[1:1], format: "2025-06-05 05:57:27" [05:57:27.347] | : . ' , ; ` | : . ' , .. .. ..$ random: int 2147483647 [05:57:27.347] | : . ' , ; ` | : . ' , ..$ r_info :List of 4 [05:57:27.347] | : . ' , ; ` | : . ' , .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [05:57:27.347] | : . ' , ; ` | : . ' , .. .. ..$ : int [1:3] 4 6 0 [05:57:27.347] | : . ' , ; ` | : . ' , .. ..$ os : chr "windows" [05:57:27.347] | : . ' , ; ` | : . ' , .. ..$ os_name : chr "Windows" [05:57:27.347] | : . ' , ; ` | : . ' , .. ..$ captures_utf8: logi TRUE [05:57:27.347] | : . ' , ; ` | : . ' , ..$ version : chr "1.8" [05:57:27.347] | : . ' , ; ` | : . ' , ..- attr(*, "class")= chr "FutureResult" [05:57:27.347] | : . ' , ; ` | : . ' , $ success: logi TRUE [05:57:27.347] | : . ' , ; ` | : . ' , $ time : 'proc_time' Named num [1:5] 0.08 0 0.08 NA NA [05:57:27.347] | : . ' , ; ` | : . ' , ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [05:57:27.347] | : . ' , ; ` | : . ' , $ tag : NULL [05:57:27.361] | : . ' , ; ` | : . ' , Received FutureResult [05:57:27.361] | : . ' , ; ` | : . ' , FutureResult: [05:57:27.361] | : . ' , ; ` | : . ' , value: 'integer' [05:57:27.361] | : . ' , ; ` | : . ' , visible: TRUE [05:57:27.361] | : . ' , ; ` | : . ' , stdout: character [05:57:27.361] | : . ' , ; ` | : . ' , conditions: [n = 0] [05:57:27.361] | : . ' , ; ` | : . ' , RNG used: FALSE [05:57:27.361] | : . ' , ; ` | : . ' , duration: 0.08099914 secs (started 2025-06-05 05:57:27.263404) [05:57:27.361] | : . ' , ; ` | : . ' , version: 1.8 [05:57:27.362] | : . ' , ; ` | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... [05:57:27.362] | : . ' , ; ` | : . ' , ; Removed future from position #1 [05:57:27.362] | : . ' , ; ` | : . ' , ; Number of registered futures: 0 [05:57:27.362] | : . ' , ; ` | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... done [05:57:27.362] | : . ' , ; ` | : . ' , Erased future from future backend [05:57:27.363] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:27.363] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:27.363] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:27.363] | : . ' , ; ` | : . ' , signalConditions() ... [05:57:27.363] | : . ' , ; ` | : . ' , ; include = 'immediateCondition' [05:57:27.363] | : . ' , ; ` | : . ' , ; exclude = [05:57:27.364] | : . ' , ; ` | : . ' , ; resignal = FALSE [05:57:27.364] | : . ' , ; ` | : . ' , ; Number of conditions: 0 [05:57:27.364] | : . ' , ; ` | : . ' , ; int 0 [05:57:27.364] | : . ' , ; ` | : . ' , signalConditions() ... done [05:57:27.365] | : . ' , ; ` | : . ' receiveMessageFromWorker() for ClusterFuture ... done [05:57:27.365] | : . ' , ; ` | : . ' receiveMessageFromWorker() returned object of class FutureResult; resolved [05:57:27.365] | : . ' , ; ` | : . resolved() for ClusterFuture () ... done [05:57:27.365] | : . ' , ; ` | : . assertFutureResult() ... [05:57:27.365] | : . ' , ; ` | : . ' Future uuid: e6fc8766d87d810603f2d8674725d8b6[05:57:27.365] | : . ' , ; ` | : . ' Future uuid: 3 [05:57:27.365] | : . ' , ; ` | : . ' identical; success [05:57:27.366] | : . ' , ; ` | : . assertFutureResult() ... done [05:57:27.366] | : . ' , ; ` | : . Future at position #1 is resolved ... [05:57:27.366] | : . ' , ; ` | : . ' value() for ClusterFuture () ... [05:57:27.366] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:27.366] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:27.366] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:27.367] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:27.367] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:27.367] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:27.367] | : . ' , ; ` | : . ' , signalConditions() ... [05:57:27.367] | : . ' , ; ` | : . ' , ; include = 'immediateCondition' [05:57:27.367] | : . ' , ; ` | : . ' , ; exclude = [05:57:27.367] | : . ' , ; ` | : . ' , ; resignal = FALSE [05:57:27.368] | : . ' , ; ` | : . ' , ; Number of conditions: 0 [05:57:27.368] | : . ' , ; ` | : . ' , ; int 0 [05:57:27.368] | : . ' , ; ` | : . ' , signalConditions() ... done [05:57:27.368] | : . ' , ; ` | : . ' , check for misuse ... [05:57:27.369] | : . ' , ; ` | : . ' , check for misuse ... done [05:57:27.369] | : . ' , ; ` | : . ' value() for ClusterFuture () ... done [05:57:27.369] | : . ' , ; ` | : . Future at position #1 is resolved ... done [05:57:27.369] | : . ' , ; ` | : collectValues('workers-37e5752128e4483a3ce8b7fda2d6c13d', firstOnly = TRUE) ... done [05:57:27.369] | : . ' , ; ` | : Remove collected futures ... [05:57:27.370] | : . ' , ; ` | : . Indices of futures to drop: [n=1] '1' [05:57:27.370] | : . ' , ; ` | : Remove collected futures ... done [05:57:27.370] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'collect-first', earlySignal = 1) ... done [05:57:27.370] | : . ' , ; ` | Early signaling of 1 future candidates ... [05:57:27.370] | : . ' , ; ` | Number of futures with early signaling requested: 0 [05:57:27.370] | : . ' , ; ` | Early signaling of 1 future candidates ... done [05:57:27.371] | : . ' , ; ` | Number of registered futures: 1 [05:57:27.371] | : . ' , ; ` Polling for a free worker ... done [05:57:27.371] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.371] | : . ' , ; ` | Listing all futures [05:57:27.371] | : . ' , ; ` | Number of registered futures: 0 [05:57:27.371] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.372] | : . ' , ; ` Total time: 0.0906000137329102 [05:57:27.372] | : . ' , ; requestNode() ... done [05:57:27.372] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.372] | : . ' , ; ` Listing all futures [05:57:27.372] | : . ' , ; ` Number of registered futures: 0 [05:57:27.372] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.372] | : . ' , ; avail: [n=1] '1' [05:57:27.373] | : . ' , ; Index of first available worker: 1 [05:57:27.373] | : . ' , ; Validate that the worker is functional ... [05:57:27.374] | : . ' , ; ` Worker is functional [05:57:27.375] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.375] | : . ' , ; ` | Listing all futures [05:57:27.375] | : . ' , ; ` | Number of registered futures: 0 [05:57:27.375] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.376] | : . ' , ; Validate that the worker is functional ... done [05:57:27.376] | : . ' , requestWorker() ... done [05:57:27.376] | : . ' , cluster node index: 1 [05:57:27.377] | : . ' launchFuture() for ClusterFutureBackend ... done [05:57:27.377] | : . ' eraseGlobalEnvironment() ... [05:57:27.377] | : . ' eraseGlobalEnvironment() ... done [05:57:27.378] | : . ' launchFuture() ... [05:57:27.378] | : . ' , cluster node index: 1 [05:57:27.378] | : . ' , getFutureData() ... [05:57:27.378] | : . ' , ; getFutureCore() ... [05:57:27.379] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:27.379] | : . ' , ; getFutureCore() ... done [05:57:27.379] | : . ' , ; getFutureCapture() ... [05:57:27.379] | : . ' , ; getFutureCapture() ... done [05:57:27.380] | : . ' , ; getFutureContext() ... [05:57:27.380] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.380] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:27.380] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.381] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:27.381] | : . ' , ; getFutureContext() ... done [05:57:27.381] | : . ' , getFutureData() ... done [05:57:27.382] | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... [05:57:27.382] | : . ' , ; Appended future to position #1 [05:57:27.383] | : . ' , ; Number of registered futures: 1 [05:57:27.383] | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... done [05:57:27.383] | : . ' launchFuture() ... done [05:57:27.383] | : . ' ClusterFuture started [05:57:27.384] | : . Launching futures ... done [05:57:27.384] | : Using ClusterFutureBackend ... done [05:57:27.384] | : Future launched: 'ClusterFuture', 'MultiprocessFuture', 'Future' [05:57:27.384] | run() for 'Future' () ... done [05:57:27.385] future(..., label = NULL) ... done [05:57:27.385] value() for list ... [05:57:27.385] | recursive: 0 [05:57:27.386] | reduce: FALSE [05:57:27.386] | length: 2 [05:57:27.386] | Number of remaining objects: 2 [05:57:27.387] | checking value #1: [05:57:27.390] | 'obj' is ClusterFuture [05:57:27.390] | ClusterFuture #1 [05:57:27.390] | signalConditionsASAP(ClusterFuture, pos=1) ... [05:57:27.390] | : nx: 2 [05:57:27.391] | : relay: TRUE [05:57:27.391] | : stdout: TRUE [05:57:27.391] | : signal: TRUE [05:57:27.391] | : resignal: FALSE [05:57:27.392] | : force: TRUE [05:57:27.392] | : relayed: [n=2] FALSE, FALSE [05:57:27.392] | : queued futures: [n=2] FALSE, FALSE [05:57:27.392] | : until=1 [05:57:27.392] | : relaying element #1 [05:57:27.393] | : value() for ClusterFuture () ... [05:57:27.393] | : . result() for ClusterFuture ... [05:57:27.393] | : . ' result already collected: FutureResult [05:57:27.393] | : . result() for ClusterFuture ... done [05:57:27.394] | : . result() for ClusterFuture ... [05:57:27.394] | : . ' result already collected: FutureResult [05:57:27.394] | : . result() for ClusterFuture ... done [05:57:27.394] | : . signalConditions() ... [05:57:27.395] | : . ' include = 'immediateCondition' [05:57:27.395] | : . ' exclude = [05:57:27.395] | : . ' resignal = FALSE [05:57:27.395] | : . ' Number of conditions: 0 [05:57:27.396] | : . ' int 0 [05:57:27.396] | : . signalConditions() ... done [05:57:27.397] | : . relay stdout ... [05:57:27.397] | : . relay stdout ... done [05:57:27.397] | : . check for misuse ... [05:57:27.397] | : . check for misuse ... done [05:57:27.398] | : value() for ClusterFuture () ... done [05:57:27.398] | : result() for ClusterFuture ... [05:57:27.398] | : . result already collected: FutureResult [05:57:27.398] | : result() for ClusterFuture ... done [05:57:27.399] | : signalConditions() ... [05:57:27.399] | : . include = 'immediateCondition' [05:57:27.399] | : . exclude = [05:57:27.399] | : . resignal = FALSE [05:57:27.400] | : . Number of conditions: 0 [05:57:27.400] | : . int 0 [05:57:27.401] | : signalConditions() ... done [05:57:27.401] | : result() for ClusterFuture ... [05:57:27.401] | : . result already collected: FutureResult [05:57:27.401] | : result() for ClusterFuture ... done [05:57:27.401] | : signalConditions() ... [05:57:27.401] | : . include = 'condition' [05:57:27.402] | : . exclude = 'error', 'immediateCondition' [05:57:27.402] | : . resignal = TRUE [05:57:27.402] | : . Number of conditions: 0 [05:57:27.402] | : . int 0 [05:57:27.403] | : signalConditions() ... done [05:57:27.403] | : relayed: [n=2] TRUE, FALSE [05:57:27.404] | : queued futures: [n=2] TRUE, FALSE [05:57:27.404] | signalConditionsASAP(ClusterFuture, pos=1) ... done [05:57:27.404] | value(, ...) ... [05:57:27.404] | value(, ...) ... done [05:57:27.404] | value() for ClusterFuture () ... [05:57:27.405] | : result() for ClusterFuture ... [05:57:27.405] | : . result already collected: FutureResult [05:57:27.405] | : result() for ClusterFuture ... done [05:57:27.405] | : result() for ClusterFuture ... [05:57:27.406] | : . result already collected: FutureResult [05:57:27.406] | : result() for ClusterFuture ... done [05:57:27.406] | : signalConditions() ... [05:57:27.406] | : . include = 'immediateCondition' [05:57:27.407] | : . exclude = [05:57:27.407] | : . resignal = FALSE [05:57:27.407] | : . Number of conditions: 0 [05:57:27.407] | : . int 0 [05:57:27.408] | : signalConditions() ... done [05:57:27.408] | : check for misuse ... [05:57:27.409] | : check for misuse ... done [05:57:27.409] | value() for ClusterFuture () ... done [05:57:27.409] | value: [05:57:27.409] | signalConditionsASAP(ClusterFuture, pos=1) ... [05:57:27.410] | : nx: 2 [05:57:27.410] | : relay: TRUE [05:57:27.410] | : stdout: TRUE [05:57:27.410] | : signal: TRUE [05:57:27.410] | : resignal: FALSE [05:57:27.411] | : force: TRUE [05:57:27.411] | : relayed: [n=2] TRUE, FALSE [05:57:27.411] | : queued futures: [n=2] TRUE, FALSE [05:57:27.411] | : until=2 [05:57:27.412] | : relaying element #2 [05:57:27.412] | : relayed: [n=2] TRUE, FALSE [05:57:27.412] | : queued futures: [n=2] TRUE, FALSE [05:57:27.412] | signalConditionsASAP(ClusterFuture, pos=1) ... done [05:57:27.413] | resolve() for ClusterFuture ... [05:57:27.413] | resolve() for ClusterFuture ... done [05:57:27.413] | length: 1 (resolved future 1) [05:57:27.413] value() for list ... done [05:57:27.414] checking value #2: [05:57:27.414] 'obj' is ClusterFuture [05:57:27.414] resolved() for ClusterFuture () ... [05:57:27.415] | Cluster node socket connection: index=4, id=179 [05:57:27.415] | assertValidConnection() ... [05:57:27.415] | : cluster node index: 1 [05:57:27.416] | assertValidConnection() ... done [05:57:27.416] | receiveMessageFromWorker() for ClusterFuture ... [05:57:27.416] | : cluster node index: 1 [05:57:27.417] | : [1] TRUE [05:57:27.417] | : received data: [05:57:27.417] | : List of 5 [05:57:27.417] | : $ type : chr "VALUE" [05:57:27.417] | : $ value :List of 16 [05:57:27.417] | : ..$ value : int 2 [05:57:27.417] | : ..$ visible : logi TRUE [05:57:27.417] | : ..$ stdout : chr "" [05:57:27.417] | : ..$ conditions : list() [05:57:27.417] | : ..$ rng : logi FALSE [05:57:27.417] | : ..$ seed : NULL [05:57:27.417] | : ..$ misuseGlobalEnv : NULL [05:57:27.417] | : ..$ misuseConnections :List of 3 [05:57:27.417] | : .. ..$ added : NULL [05:57:27.417] | : .. ..$ removed : NULL [05:57:27.417] | : .. ..$ replaced: NULL [05:57:27.417] | : ..$ misuseDevices : NULL [05:57:27.417] | : ..$ misuseDefaultDevice: list() [05:57:27.417] | : ..$ started : POSIXct[1:1], format: "2025-06-05 05:57:27" [05:57:27.417] | : ..$ finished : POSIXct[1:1], format: "2025-06-05 05:57:27" [05:57:27.417] | : ..$ uuid : chr [1:2] "e6fc8766d87d810603f2d8674725d8b6" "4" [05:57:27.417] | : ..$ session_uuid : chr "2117cfd314f1fb5440e35b1600f029f9" [05:57:27.417] | : .. ..- attr(*, "source")=List of 5 [05:57:27.417] | : .. .. ..$ host : Named chr "CRANWIN3" [05:57:27.417] | : .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [05:57:27.417] | : .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:27.417] | : .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:27.417] | : .. .. ..$ pid : int 76792 [05:57:27.417] | : .. .. ..$ time : POSIXct[1:1], format: "2025-06-05 05:57:27" [05:57:27.417] | : .. .. ..$ random: int 2147483647 [05:57:27.417] | : ..$ r_info :List of 4 [05:57:27.417] | : .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [05:57:27.417] | : .. .. ..$ : int [1:3] 4 6 0 [05:57:27.417] | : .. ..$ os : chr "windows" [05:57:27.417] | : .. ..$ os_name : chr "Windows" [05:57:27.417] | : .. ..$ captures_utf8: logi TRUE [05:57:27.417] | : ..$ version : chr "1.8" [05:57:27.417] | : ..- attr(*, "class")= chr "FutureResult" [05:57:27.417] | : $ success: logi TRUE [05:57:27.417] | : $ time : 'proc_time' Named num [1:5] 0.02 0 0.01 NA NA [05:57:27.417] | : ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [05:57:27.417] | : $ tag : NULL [05:57:27.437] | : Received FutureResult [05:57:27.437] | : FutureResult: [05:57:27.437] | : value: 'integer' [05:57:27.437] | : visible: TRUE [05:57:27.437] | : stdout: character [05:57:27.437] | : conditions: [n = 0] [05:57:27.437] | : RNG used: FALSE [05:57:27.437] | : duration: 0.005023956 secs (started 2025-06-05 05:57:27.382844) [05:57:27.437] | : version: 1.8 [05:57:27.438] | : FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... [05:57:27.438] | : . Removed future from position #1 [05:57:27.439] | : . Number of registered futures: 0 [05:57:27.439] | : FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... done [05:57:27.439] | : Erased future from future backend [05:57:27.440] | : result() for ClusterFuture ... [05:57:27.440] | : . result already collected: FutureResult [05:57:27.440] | : result() for ClusterFuture ... done [05:57:27.440] | : signalConditions() ... [05:57:27.441] | : . include = 'immediateCondition' [05:57:27.441] | : . exclude = [05:57:27.441] | : . resignal = FALSE [05:57:27.441] | : . Number of conditions: 0 [05:57:27.442] | : . int 0 [05:57:27.442] | : signalConditions() ... done [05:57:27.443] | receiveMessageFromWorker() for ClusterFuture ... done [05:57:27.443] | receiveMessageFromWorker() returned object of class FutureResult; resolved [05:57:27.443] resolved() for ClusterFuture () ... done [05:57:27.443] assertFutureResult() ... [05:57:27.443] | Future uuid: e6fc8766d87d810603f2d8674725d8b6[05:57:27.443] | Future uuid: 4 [05:57:27.444] | identical; success [05:57:27.444] assertFutureResult() ... done [05:57:27.444] ClusterFuture #2 [05:57:27.444] signalConditionsASAP(ClusterFuture, pos=2) ... [05:57:27.445] | nx: 2 [05:57:27.445] | relay: TRUE [05:57:27.445] | stdout: TRUE [05:57:27.445] | signal: TRUE [05:57:27.446] | resignal: FALSE [05:57:27.446] | force: TRUE [05:57:27.446] | relayed: [n=2] TRUE, FALSE [05:57:27.446] | queued futures: [n=2] TRUE, FALSE [05:57:27.446] | until=2 [05:57:27.447] | relaying element #2 [05:57:27.447] | value() for ClusterFuture () ... [05:57:27.447] | : result() for ClusterFuture ... [05:57:27.447] | : . result already collected: FutureResult [05:57:27.448] | : result() for ClusterFuture ... done [05:57:27.448] | : result() for ClusterFuture ... [05:57:27.448] | : . result already collected: FutureResult [05:57:27.448] | : result() for ClusterFuture ... done [05:57:27.449] | : signalConditions() ... [05:57:27.449] | : . include = 'immediateCondition' [05:57:27.449] | : . exclude = [05:57:27.449] | : . resignal = FALSE [05:57:27.449] | : . Number of conditions: 0 [05:57:27.450] | : . int 0 [05:57:27.450] | : signalConditions() ... done [05:57:27.450] | : relay stdout ... [05:57:27.450] | : relay stdout ... done [05:57:27.451] | : check for misuse ... [05:57:27.451] | : check for misuse ... done [05:57:27.451] | value() for ClusterFuture () ... done [05:57:27.451] | result() for ClusterFuture ... [05:57:27.452] | : result already collected: FutureResult [05:57:27.452] | result() for ClusterFuture ... done [05:57:27.452] | signalConditions() ... [05:57:27.452] | : include = 'immediateCondition' [05:57:27.453] | : exclude = [05:57:27.453] | : resignal = FALSE [05:57:27.453] | : Number of conditions: 0 [05:57:27.453] | : int 0 [05:57:27.454] | signalConditions() ... done [05:57:27.454] | result() for ClusterFuture ... [05:57:27.454] | : result already collected: FutureResult [05:57:27.455] | result() for ClusterFuture ... done [05:57:27.455] | signalConditions() ... [05:57:27.455] | : include = 'condition' [05:57:27.455] | : exclude = 'error', 'immediateCondition' [05:57:27.456] | : resignal = TRUE [05:57:27.456] | : Number of conditions: 0 [05:57:27.456] | : int 0 [05:57:27.457] | signalConditions() ... done [05:57:27.457] | relayed: [n=2] TRUE, TRUE [05:57:27.457] | queued futures: [n=2] TRUE, TRUE [05:57:27.457] signalConditionsASAP(ClusterFuture, pos=2) ... done [05:57:27.457] value(, ...) ... [05:57:27.457] value(, ...) ... done [05:57:27.458] value() for ClusterFuture () ... [05:57:27.458] | result() for ClusterFuture ... [05:57:27.458] | : result already collected: FutureResult [05:57:27.458] | result() for ClusterFuture ... done [05:57:27.458] | result() for ClusterFuture ... [05:57:27.458] | : result already collected: FutureResult [05:57:27.459] | result() for ClusterFuture ... done [05:57:27.459] | signalConditions() ... [05:57:27.459] | : include = 'immediateCondition' [05:57:27.459] | : exclude = [05:57:27.459] | : resignal = FALSE [05:57:27.459] | : Number of conditions: 0 [05:57:27.459] | : int 0 [05:57:27.460] | signalConditions() ... done [05:57:27.460] | check for misuse ... [05:57:27.460] | check for misuse ... done [05:57:27.461] value() for ClusterFuture () ... done [05:57:27.461] value: [05:57:27.461] signalConditionsASAP(ClusterFuture, pos=2) ... [05:57:27.461] | nx: 2 [05:57:27.461] | relay: TRUE [05:57:27.461] | stdout: TRUE [05:57:27.461] | signal: TRUE [05:57:27.462] | resignal: FALSE [05:57:27.462] | force: TRUE [05:57:27.462] | relayed: [n=2] TRUE, TRUE [05:57:27.462] | queued futures: [n=2] TRUE, TRUE [05:57:27.463] | until=2 [05:57:27.463] | relayed: [n=2] TRUE, TRUE [05:57:27.463] | queued futures: [n=2] TRUE, TRUE [05:57:27.463] signalConditionsASAP(ClusterFuture, pos=2) ... done [05:57:27.464] resolve() for ClusterFuture ... [05:57:27.464] resolve() for ClusterFuture ... done [05:57:27.464] length: 0 (resolved future 2) [05:57:27.465] Relaying remaining futures ... [05:57:27.465] | signalConditionsASAP(NULL, pos=0) ... [05:57:27.465] | : nx: 2 [05:57:27.465] | : relay: TRUE [05:57:27.466] | : stdout: TRUE [05:57:27.466] | : signal: TRUE [05:57:27.466] | : resignal: FALSE [05:57:27.466] | : force: TRUE [05:57:27.466] | : relayed: [n=2] TRUE, TRUE [05:57:27.467] | : queued futures: [n=2] TRUE, TRUE - flush all [05:57:27.467] | : relayed: [n=2] TRUE, TRUE [05:57:27.467] | : queued futures: [n=2] TRUE, TRUE [05:57:27.468] | signalConditionsASAP(NULL, pos=0) ... done [05:57:27.468] Relaying remaining futures ... done Iteration #3 [05:57:27.760] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.761] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... [05:57:27.762] | : all.equal() for FutureStrategyList ... [05:57:27.762] | : . New stack: [05:57:27.763] | : . List of 1 [05:57:27.763] | : . $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.763] | : . envir = parent.frame()) [05:57:27.763] | : . ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.763] | : . ..- attr(*, "init")= logi TRUE [05:57:27.763] | : . ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.763] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.763] | : . .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.763] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.763] | : . ..- attr(*, "tweaks")=List of 1 [05:57:27.763] | : . .. ..$ workers:List of 1 [05:57:27.763] | : . .. .. ..$ :List of 3 [05:57:27.763] | : . .. .. .. ..$ con : 'sockconn' int 4 [05:57:27.763] | : . .. .. .. .. ..- attr(*, "conn_id")= [05:57:27.763] | : . .. .. .. ..$ host: chr "localhost" [05:57:27.763] | : . .. .. .. ..$ rank: num 0 [05:57:27.763] | : . .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.763] | : . .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.763] | : . ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.763] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:27.776] | : . Old stack: [05:57:27.776] | : . List of 1 [05:57:27.776] | : . $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.776] | : . envir = parent.frame()) [05:57:27.776] | : . ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.776] | : . ..- attr(*, "init")= chr "done" [05:57:27.776] | : . ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.776] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.776] | : . .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.776] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.776] | : . ..- attr(*, "tweaks")=List of 1 [05:57:27.776] | : . .. ..$ workers:List of 1 [05:57:27.776] | : . .. .. ..$ :List of 3 [05:57:27.776] | : . .. .. .. ..$ con : 'sockconn' int 4 [05:57:27.776] | : . .. .. .. .. ..- attr(*, "conn_id")= [05:57:27.776] | : . .. .. .. ..$ host: chr "localhost" [05:57:27.776] | : . .. .. .. ..$ rank: num 0 [05:57:27.776] | : . .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.776] | : . .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.776] | : . ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.776] | : . ..- attr(*, "backend")=Classes 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment' [05:57:27.776] | : . .. ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.776] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.776] | : . .. .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.776] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:27.790] | : . Not identical [05:57:27.791] | : . all.equal() for future ... [05:57:27.791] | : . ' List of 2 [05:57:27.791] | : . ' $ target :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.791] | : . ' envir = parent.frame()) [05:57:27.791] | : . ' ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.791] | : . ' ..- attr(*, "init")= logi TRUE [05:57:27.791] | : . ' ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.791] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.791] | : . ' .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.791] | : . ' ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.791] | : . ' ..- attr(*, "tweaks")=List of 1 [05:57:27.791] | : . ' .. ..$ workers:List of 1 [05:57:27.791] | : . ' .. .. ..$ :List of 3 [05:57:27.791] | : . ' .. .. .. ..$ con : 'sockconn' int 4 [05:57:27.791] | : . ' .. .. .. .. ..- attr(*, "conn_id")= [05:57:27.791] | : . ' .. .. .. ..$ host: chr "localhost" [05:57:27.791] | : . ' .. .. .. ..$ rank: num 0 [05:57:27.791] | : . ' .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.791] | : . ' .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.791] | : . ' ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.791] | : . ' $ current:function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.791] | : . ' envir = parent.frame()) [05:57:27.791] | : . ' ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.791] | : . ' ..- attr(*, "init")= chr "done" [05:57:27.791] | : . ' ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.791] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.791] | : . ' .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.791] | : . ' ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.791] | : . ' ..- attr(*, "tweaks")=List of 1 [05:57:27.791] | : . ' .. ..$ workers:List of 1 [05:57:27.791] | : . ' .. .. ..$ :List of 3 [05:57:27.791] | : . ' .. .. .. ..$ con : 'sockconn' int 4 [05:57:27.791] | : . ' .. .. .. .. ..- attr(*, "conn_id")= [05:57:27.791] | : . ' .. .. .. ..$ host: chr "localhost" [05:57:27.791] | : . ' .. .. .. ..$ rank: num 0 [05:57:27.791] | : . ' .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.791] | : . ' .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.791] | : . ' ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.791] | : . ' ..- attr(*, "backend")=Classes 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment' [05:57:27.791] | : . ' .. ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.791] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.791] | : . ' .. .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.817] | : . ' Formals differ [05:57:27.818] | : . all.equal() for future ... done [05:57:27.818] | : . Future strategies differ at level 1 [05:57:27.818] | : all.equal() for FutureStrategyList ... done [05:57:27.819] | : plan(): Setting new future backend stack: [05:57:27.819] | : List of future strategies: [05:57:27.819] | : 1. cluster: [05:57:27.819] | : - args: function (..., workers = "", envir = parent.frame()) [05:57:27.819] | : - tweaked: TRUE [05:57:27.819] | : - call: plan(cluster, workers = cl) [05:57:27.820] | : List of 1 [05:57:27.820] | : $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.820] | : envir = parent.frame()) [05:57:27.820] | : ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.820] | : ..- attr(*, "init")= logi TRUE [05:57:27.820] | : ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.820] | : earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.820] | : .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.820] | : ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.820] | : ..- attr(*, "tweaks")=List of 1 [05:57:27.820] | : .. ..$ workers:List of 1 [05:57:27.820] | : .. .. ..$ :List of 3 [05:57:27.820] | : .. .. .. ..$ con : 'sockconn' int 4 [05:57:27.820] | : .. .. .. .. ..- attr(*, "conn_id")= [05:57:27.820] | : .. .. .. ..$ host: chr "localhost" [05:57:27.820] | : .. .. .. ..$ rank: num 0 [05:57:27.820] | : .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.820] | : .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.820] | : ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.820] | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:27.832] | : plan(): plan_cleanup('tweaked', 'cluster', 'multiprocess', 'future', 'function', cleanup = NA) ... [05:57:27.832] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.832] | : . ' Getting current ("next") strategy: 'FutureStrategy', 'tweaked', 'cluster', 'multiprocess', 'future', 'function' [05:57:27.833] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.833] | : . stopWorkers() for ClusterFutureBackend ... [05:57:27.833] | : . ' Interrupt active futures ... [05:57:27.837] | : . ' , Number of futures: 0 [05:57:27.838] | : . ' Interrupt active futures ... done [05:57:27.838] | : . ' Clear future registry ... [05:57:27.839] | : . ' Clear future registry ... done [05:57:27.839] | : . ' Stop cluster workers ... [05:57:27.839] | : . ' , Stopping existing cluster ... [05:57:27.840] | : . ' , ; No pre-existing cluster. Skipping [05:57:27.840] | : . ' , Stopping existing cluster ... done [05:57:27.840] | : . ' Stop cluster workers ... done [05:57:27.840] | : . stopWorkers() for ClusterFutureBackend ... done [05:57:27.841] | : . Legacy shutdown of cluster workers ... [05:57:27.841] | : . ' Stopping existing cluster ... [05:57:27.841] | : . ' , No pre-existing cluster. Skipping [05:57:27.841] | : . ' Stopping existing cluster ... done [05:57:27.842] | : . Legacy shutdown of cluster workers ... done [05:57:27.842] | : plan(): plan_cleanup('tweaked', 'cluster', 'multiprocess', 'future', 'function', cleanup = NA) ... done [05:57:27.842] | : plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... [05:57:27.843] | : . function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:27.843] | : . envir = parent.frame()) [05:57:27.843] | : . - attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:27.843] | : . - attr(*, "init")= logi TRUE [05:57:27.843] | : . - attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:27.843] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:27.843] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.843] | : . - attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:27.843] | : . - attr(*, "tweaks")=List of 1 [05:57:27.843] | : . ..$ workers:List of 1 [05:57:27.843] | : . .. ..$ :List of 3 [05:57:27.843] | : . .. .. ..$ con : 'sockconn' int 4 [05:57:27.843] | : . .. .. .. ..- attr(*, "conn_id")= [05:57:27.843] | : . .. .. ..$ host: chr "localhost" [05:57:27.843] | : . .. .. ..$ rank: num 0 [05:57:27.843] | : . .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.843] | : . .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.843] | : . - attr(*, "call")= language plan(cluster, workers = cl) [05:57:27.852] | : . init: TRUE [05:57:27.853] | : . makeFutureBackend() ... [05:57:27.853] | : . ' Backend function: <'NULL'> [05:57:27.853] | : . ' Evaluator tweak arguments: [n=1] [05:57:27.854] | : . ' List of 1 [05:57:27.854] | : . ' $ workers:List of 1 [05:57:27.854] | : . ' ..$ :List of 3 [05:57:27.854] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:27.854] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:27.854] | : . ' .. ..$ host: chr "localhost" [05:57:27.854] | : . ' .. ..$ rank: num 0 [05:57:27.854] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.854] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.859] | : . ' Evaluator formal arguments: [n=1] [05:57:27.859] | : . ' List of 1 [05:57:27.859] | : . ' $ workers:List of 1 [05:57:27.859] | : . ' ..$ :List of 3 [05:57:27.859] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:27.859] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:27.859] | : . ' .. ..$ host: chr "localhost" [05:57:27.859] | : . ' .. ..$ rank: num 0 [05:57:27.859] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.859] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.865] | : . ' Backend factory arguments: [n=1] [05:57:27.865] | : . ' Dotted pair list of 1 [05:57:27.865] | : . ' $ workers:List of 1 [05:57:27.865] | : . ' ..$ :List of 3 [05:57:27.865] | : . ' .. ..$ con : 'sockconn' int 4 [05:57:27.865] | : . ' .. .. ..- attr(*, "conn_id")= [05:57:27.865] | : . ' .. ..$ host: chr "localhost" [05:57:27.865] | : . ' .. ..$ rank: num 0 [05:57:27.865] | : . ' .. ..- attr(*, "class")= chr "SOCKnode" [05:57:27.865] | : . ' ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:27.870] | : . ' ClusterFutureBackend(..., persistent = FALSE, gc = TRUE, earlySignal = TRUE) ... [05:57:27.871] | : . ' , Stopping existing cluster ... [05:57:27.871] | : . ' , ; No pre-existing cluster. Skipping [05:57:27.871] | : . ' , Stopping existing cluster ... done [05:57:27.872] | : . ' , Number of workers: 1 [05:57:27.872] | : . ' , Generated workers UUID [05:57:27.872] | : . ' , Workers UUID: '37e5752128e4483a3ce8b7fda2d6c13d' [05:57:27.873] | : . ' ClusterFutureBackend(..., persistent = FALSE, gc = TRUE, earlySignal = TRUE) ... done [05:57:27.873] | : . ' Backend: <'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment'> [05:57:27.873] | : . makeFutureBackend() ... done [05:57:27.873] | : plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... done [05:57:27.874] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.874] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.874] | : plan(): nbrOfWorkers() = 1 [05:57:27.875] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done [05:57:27.875] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.875] future(..., label = NULL) ... [05:57:27.876] | lazy: FALSE [05:57:27.876] | stdout: TRUE [05:57:27.876] | conditions: [n=1] 'condition' [05:57:27.876] | gc: FALSE [05:57:27.877] | earlySignal: FALSE [05:57:27.877] | getGlobalsAndPackages() ... [05:57:27.877] | : Searching for globals ... [05:57:27.886] | : . globals found: [3] '[[', 'X', 'i' [05:57:27.886] | : Searching for globals ... done [05:57:27.886] | : Resolving globals: FALSE [05:57:27.887] | : Search for packages associated with the globals ... [05:57:27.887] | : . Packages associated with globals: [1] 'base' [05:57:27.888] | : . Packages: [1] 'base' [05:57:27.888] | : Search for packages associated with the globals ... done [05:57:27.888] | : Packages after dropping 'base': [0] [05:57:27.889] | : globals: [2] 'X', 'i' [05:57:27.889] | : packages: [0] [05:57:27.889] | getGlobalsAndPackages() ... done [05:57:27.890] | run() for 'Future' () ... [05:57:27.890] | : state: 'created' [05:57:27.891] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:27.891] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:27.891] | : Using ClusterFutureBackend ... [05:57:27.892] | : . Number of futures since start: 0 (0 created, 0 launched, 0 finished) [05:57:27.892] | : . Launching futures ... [05:57:27.892] | : . ' launchFuture() for ClusterFutureBackend ... [05:57:27.892] | : . ' , Workers: [n=1] [05:57:27.893] | : . ' , socket cluster with 1 nodes on host 'localhost' [05:57:27.893] | : . ' , FutureRegistry: 'workers-37e5752128e4483a3ce8b7fda2d6c13d' [05:57:27.894] | : . ' , requestWorker() ... [05:57:27.894] | : . ' , ; requestNode() ... [05:57:27.894] | : . ' , ; ` Number of workers: 1 [05:57:27.895] | : . ' , ; ` Polling for a free worker ... [05:57:27.895] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.895] | : . ' , ; ` | : Listing all futures [05:57:27.895] | : . ' , ; ` | : Number of registered futures: 0 [05:57:27.896] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.896] | : . ' , ; ` | Total time: 0 [05:57:27.896] | : . ' , ; ` Polling for a free worker ... done [05:57:27.897] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:27.897] | : . ' , ; ` | Listing all futures [05:57:27.897] | : . ' , ; ` | Number of registered futures: 0 [05:57:27.897] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:27.898] | : . ' , ; ` avail: [n=1] '1' [05:57:27.898] | : . ' , ; ` Index of first available worker: 1 [05:57:27.898] | : . ' , ; ` Validate that the worker is functional ... [05:57:28.032] | : . ' , ; ` | Worker is functional [05:57:28.033] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:28.033] | : . ' , ; ` | : Listing all futures [05:57:28.034] | : . ' , ; ` | : Number of registered futures: 0 [05:57:28.034] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:28.034] | : . ' , ; ` Validate that the worker is functional ... done [05:57:28.035] | : . ' , ; requestNode() ... done [05:57:28.035] | : . ' , ; cluster node index: 1 [05:57:28.035] | : . ' , requestWorker() ... done [05:57:28.036] | : . ' , eraseGlobalEnvironment() ... [05:57:28.037] | : . ' , eraseGlobalEnvironment() ... done [05:57:28.037] | : . ' , launchFuture() ... [05:57:28.037] | : . ' , ; cluster node index: 1 [05:57:28.037] | : . ' , ; getFutureData() ... [05:57:28.038] | : . ' , ; ` getFutureCore() ... [05:57:28.038] | : . ' , ; ` | Packages needed by the future expression (n = 0): [05:57:28.038] | : . ' , ; ` getFutureCore() ... done [05:57:28.039] | : . ' , ; ` getFutureCapture() ... [05:57:28.039] | : . ' , ; ` getFutureCapture() ... done [05:57:28.039] | : . ' , ; ` getFutureContext() ... [05:57:28.040] | : . ' , ; ` | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:28.040] | : . ' , ; ` | : Getting stack without first backend: [n=0] [05:57:28.040] | : . ' , ; ` | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:28.041] | : . ' , ; ` | Packages needed by future backend (n = 0): [05:57:28.041] | : . ' , ; ` getFutureContext() ... done [05:57:28.041] | : . ' , ; getFutureData() ... done [05:57:28.042] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... [05:57:28.043] | : . ' , ; ` Appended future to position #1 [05:57:28.043] | : . ' , ; ` Number of registered futures: 1 [05:57:28.044] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... done [05:57:28.044] | : . ' , launchFuture() ... done [05:57:28.044] | : . ' , ClusterFuture started [05:57:28.044] | : . ' launchFuture() for ClusterFutureBackend ... done [05:57:28.045] | : . Launching futures ... done [05:57:28.045] | : . Future launched: 'ClusterFuture', 'MultiprocessFuture', 'Future' [05:57:28.045] | : Using ClusterFutureBackend ... done [05:57:28.046] | run() for 'Future' () ... done [05:57:28.046] future(..., label = NULL) ... done [05:57:28.046] future(..., label = NULL) ... [05:57:28.047] | lazy: FALSE [05:57:28.047] | stdout: TRUE [05:57:28.047] | conditions: [n=1] 'condition' [05:57:28.048] | gc: FALSE [05:57:28.048] | earlySignal: FALSE [05:57:28.048] | getGlobalsAndPackages() ... [05:57:28.049] | : Searching for globals ... [05:57:28.058] | : . globals found: [3] '[[', 'X', 'i' [05:57:28.058] | : Searching for globals ... done [05:57:28.059] | : Resolving globals: FALSE [05:57:28.059] | : Search for packages associated with the globals ... [05:57:28.060] | : . Packages associated with globals: [1] 'base' [05:57:28.060] | : . Packages: [1] 'base' [05:57:28.061] | : Search for packages associated with the globals ... done [05:57:28.061] | : Packages after dropping 'base': [0] [05:57:28.061] | : globals: [2] 'X', 'i' [05:57:28.062] | : packages: [0] [05:57:28.062] | getGlobalsAndPackages() ... done [05:57:28.063] | run() for 'Future' () ... [05:57:28.063] | : state: 'created' [05:57:28.063] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:28.064] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:28.064] | : Using ClusterFutureBackend ... [05:57:28.064] | : . Number of futures since start: 1 (1 created, 1 launched, 0 finished) [05:57:28.065] | : . Launching futures ... [05:57:28.065] | : . ' launchFuture() for ClusterFutureBackend ... [05:57:28.065] | : . ' , Workers: [n=1] [05:57:28.066] | : . ' , socket cluster with 1 nodes on host 'localhost' [05:57:28.066] | : . ' , FutureRegistry: 'workers-37e5752128e4483a3ce8b7fda2d6c13d' [05:57:28.067] | : . ' , requestWorker() ... [05:57:28.067] | : . ' , ; requestNode() ... [05:57:28.067] | : . ' , ; ` Number of workers: 1 [05:57:28.068] | : . ' , ; ` Polling for a free worker ... [05:57:28.068] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:28.069] | : . ' , ; ` | : Listing all futures [05:57:28.069] | : . ' , ; ` | : Number of registered futures: 1 [05:57:28.069] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:28.069] | : . ' , ; ` | Poll #1 (0): usedNodes() = 1, workers = 1 [05:57:28.089] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'collect-first', earlySignal = 1) ... [05:57:28.090] | : . ' , ; ` | : collectValues('workers-37e5752128e4483a3ce8b7fda2d6c13d', firstOnly = TRUE) ... [05:57:28.090] | : . ' , ; ` | : . resolved() for ClusterFuture () ... [05:57:28.091] | : . ' , ; ` | : . ' Cluster node socket connection: index=4, id=219 [05:57:28.092] | : . ' , ; ` | : . ' assertValidConnection() ... [05:57:28.092] | : . ' , ; ` | : . ' , cluster node index: 1 [05:57:28.093] | : . ' , ; ` | : . ' assertValidConnection() ... done [05:57:28.149] | : . ' , ; ` | : . ' receiveMessageFromWorker() for ClusterFuture ... [05:57:28.149] | : . ' , ; ` | : . ' , cluster node index: 1 [05:57:28.150] | : . ' , ; ` | : . ' , [1] TRUE [05:57:28.150] | : . ' , ; ` | : . ' , received data: [05:57:28.150] | : . ' , ; ` | : . ' , List of 5 [05:57:28.150] | : . ' , ; ` | : . ' , $ type : chr "VALUE" [05:57:28.150] | : . ' , ; ` | : . ' , $ value :List of 16 [05:57:28.150] | : . ' , ; ` | : . ' , ..$ value : int 1 [05:57:28.150] | : . ' , ; ` | : . ' , ..$ visible : logi TRUE [05:57:28.150] | : . ' , ; ` | : . ' , ..$ stdout : chr "" [05:57:28.150] | : . ' , ; ` | : . ' , ..$ conditions : list() [05:57:28.150] | : . ' , ; ` | : . ' , ..$ rng : logi FALSE [05:57:28.150] | : . ' , ; ` | : . ' , ..$ seed : NULL [05:57:28.150] | : . ' , ; ` | : . ' , ..$ misuseGlobalEnv : NULL [05:57:28.150] | : . ' , ; ` | : . ' , ..$ misuseConnections :List of 3 [05:57:28.150] | : . ' , ; ` | : . ' , .. ..$ added : NULL [05:57:28.150] | : . ' , ; ` | : . ' , .. ..$ removed : NULL [05:57:28.150] | : . ' , ; ` | : . ' , .. ..$ replaced: NULL [05:57:28.150] | : . ' , ; ` | : . ' , ..$ misuseDevices : NULL [05:57:28.150] | : . ' , ; ` | : . ' , ..$ misuseDefaultDevice: list() [05:57:28.150] | : . ' , ; ` | : . ' , ..$ started : POSIXct[1:1], format: "2025-06-05 05:57:28" [05:57:28.150] | : . ' , ; ` | : . ' , ..$ finished : POSIXct[1:1], format: "2025-06-05 05:57:28" [05:57:28.150] | : . ' , ; ` | : . ' , ..$ uuid : chr [1:2] "e6fc8766d87d810603f2d8674725d8b6" "5" [05:57:28.150] | : . ' , ; ` | : . ' , ..$ session_uuid : chr "54c76b9fc393ac059bfce4a3621d4e21" [05:57:28.150] | : . ' , ; ` | : . ' , .. ..- attr(*, "source")=List of 5 [05:57:28.150] | : . ' , ; ` | : . ' , .. .. ..$ host : Named chr "CRANWIN3" [05:57:28.150] | : . ' , ; ` | : . ' , .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [05:57:28.150] | : . ' , ; ` | : . ' , .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:28.150] | : . ' , ; ` | : . ' , .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:28.150] | : . ' , ; ` | : . ' , .. .. ..$ pid : int 161132 [05:57:28.150] | : . ' , ; ` | : . ' , .. .. ..$ time : POSIXct[1:1], format: "2025-06-05 05:57:28" [05:57:28.150] | : . ' , ; ` | : . ' , .. .. ..$ random: int 2147483647 [05:57:28.150] | : . ' , ; ` | : . ' , ..$ r_info :List of 4 [05:57:28.150] | : . ' , ; ` | : . ' , .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [05:57:28.150] | : . ' , ; ` | : . ' , .. .. ..$ : int [1:3] 4 6 0 [05:57:28.150] | : . ' , ; ` | : . ' , .. ..$ os : chr "windows" [05:57:28.150] | : . ' , ; ` | : . ' , .. ..$ os_name : chr "Windows" [05:57:28.150] | : . ' , ; ` | : . ' , .. ..$ captures_utf8: logi TRUE [05:57:28.150] | : . ' , ; ` | : . ' , ..$ version : chr "1.8" [05:57:28.150] | : . ' , ; ` | : . ' , ..- attr(*, "class")= chr "FutureResult" [05:57:28.150] | : . ' , ; ` | : . ' , $ success: logi TRUE [05:57:28.150] | : . ' , ; ` | : . ' , $ time : 'proc_time' Named num [1:5] 0.06 0 0.09 NA NA [05:57:28.150] | : . ' , ; ` | : . ' , ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [05:57:28.150] | : . ' , ; ` | : . ' , $ tag : NULL [05:57:28.172] | : . ' , ; ` | : . ' , Received FutureResult [05:57:28.172] | : . ' , ; ` | : . ' , FutureResult: [05:57:28.172] | : . ' , ; ` | : . ' , value: 'integer' [05:57:28.172] | : . ' , ; ` | : . ' , visible: TRUE [05:57:28.172] | : . ' , ; ` | : . ' , stdout: character [05:57:28.172] | : . ' , ; ` | : . ' , conditions: [n = 0] [05:57:28.172] | : . ' , ; ` | : . ' , RNG used: FALSE [05:57:28.172] | : . ' , ; ` | : . ' , duration: 0.103266 secs (started 2025-06-05 05:57:28.044566) [05:57:28.172] | : . ' , ; ` | : . ' , version: 1.8 [05:57:28.173] | : . ' , ; ` | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... [05:57:28.173] | : . ' , ; ` | : . ' , ; Removed future from position #1 [05:57:28.174] | : . ' , ; ` | : . ' , ; Number of registered futures: 0 [05:57:28.174] | : . ' , ; ` | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... done [05:57:28.174] | : . ' , ; ` | : . ' , Erased future from future backend [05:57:28.175] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:28.175] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:28.175] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:28.175] | : . ' , ; ` | : . ' , signalConditions() ... [05:57:28.176] | : . ' , ; ` | : . ' , ; include = 'immediateCondition' [05:57:28.176] | : . ' , ; ` | : . ' , ; exclude = [05:57:28.176] | : . ' , ; ` | : . ' , ; resignal = FALSE [05:57:28.176] | : . ' , ; ` | : . ' , ; Number of conditions: 0 [05:57:28.177] | : . ' , ; ` | : . ' , ; int 0 [05:57:28.178] | : . ' , ; ` | : . ' , signalConditions() ... done [05:57:28.178] | : . ' , ; ` | : . ' receiveMessageFromWorker() for ClusterFuture ... done [05:57:28.178] | : . ' , ; ` | : . ' receiveMessageFromWorker() returned object of class FutureResult; resolved [05:57:28.178] | : . ' , ; ` | : . resolved() for ClusterFuture () ... done [05:57:28.179] | : . ' , ; ` | : . assertFutureResult() ... [05:57:28.179] | : . ' , ; ` | : . ' Future uuid: e6fc8766d87d810603f2d8674725d8b6[05:57:28.179] | : . ' , ; ` | : . ' Future uuid: 5 [05:57:28.179] | : . ' , ; ` | : . ' identical; success [05:57:28.179] | : . ' , ; ` | : . assertFutureResult() ... done [05:57:28.180] | : . ' , ; ` | : . Future at position #1 is resolved ... [05:57:28.180] | : . ' , ; ` | : . ' value() for ClusterFuture () ... [05:57:28.180] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:28.181] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:28.181] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:28.181] | : . ' , ; ` | : . ' , result() for ClusterFuture ... [05:57:28.181] | : . ' , ; ` | : . ' , ; result already collected: FutureResult [05:57:28.182] | : . ' , ; ` | : . ' , result() for ClusterFuture ... done [05:57:28.182] | : . ' , ; ` | : . ' , signalConditions() ... [05:57:28.182] | : . ' , ; ` | : . ' , ; include = 'immediateCondition' [05:57:28.182] | : . ' , ; ` | : . ' , ; exclude = [05:57:28.183] | : . ' , ; ` | : . ' , ; resignal = FALSE [05:57:28.183] | : . ' , ; ` | : . ' , ; Number of conditions: 0 [05:57:28.183] | : . ' , ; ` | : . ' , ; int 0 [05:57:28.184] | : . ' , ; ` | : . ' , signalConditions() ... done [05:57:28.184] | : . ' , ; ` | : . ' , check for misuse ... [05:57:28.184] | : . ' , ; ` | : . ' , check for misuse ... done [05:57:28.185] | : . ' , ; ` | : . ' value() for ClusterFuture () ... done [05:57:28.185] | : . ' , ; ` | : . Future at position #1 is resolved ... done [05:57:28.185] | : . ' , ; ` | : collectValues('workers-37e5752128e4483a3ce8b7fda2d6c13d', firstOnly = TRUE) ... done [05:57:28.186] | : . ' , ; ` | : Remove collected futures ... [05:57:28.186] | : . ' , ; ` | : . Indices of futures to drop: [n=1] '1' [05:57:28.186] | : . ' , ; ` | : Remove collected futures ... done [05:57:28.186] | : . ' , ; ` | FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'collect-first', earlySignal = 1) ... done [05:57:28.186] | : . ' , ; ` | Early signaling of 1 future candidates ... [05:57:28.187] | : . ' , ; ` | Number of futures with early signaling requested: 0 [05:57:28.187] | : . ' , ; ` | Early signaling of 1 future candidates ... done [05:57:28.187] | : . ' , ; ` | Number of registered futures: 1 [05:57:28.187] | : . ' , ; ` Polling for a free worker ... done [05:57:28.188] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:28.188] | : . ' , ; ` | Listing all futures [05:57:28.188] | : . ' , ; ` | Number of registered futures: 0 [05:57:28.188] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:28.189] | : . ' , ; ` Total time: 0.119409084320068 [05:57:28.189] | : . ' , ; requestNode() ... done [05:57:28.189] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:28.189] | : . ' , ; ` Listing all futures [05:57:28.190] | : . ' , ; ` Number of registered futures: 0 [05:57:28.190] | : . ' , ; FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:28.190] | : . ' , ; avail: [n=1] '1' [05:57:28.191] | : . ' , ; Index of first available worker: 1 [05:57:28.191] | : . ' , ; Validate that the worker is functional ... [05:57:28.193] | : . ' , ; ` Worker is functional [05:57:28.193] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... [05:57:28.193] | : . ' , ; ` | Listing all futures [05:57:28.193] | : . ' , ; ` | Number of registered futures: 0 [05:57:28.194] | : . ' , ; ` FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'list', earlySignal = 0) ... done [05:57:28.194] | : . ' , ; Validate that the worker is functional ... done [05:57:28.194] | : . ' , requestWorker() ... done [05:57:28.194] | : . ' , cluster node index: 1 [05:57:28.195] | : . ' launchFuture() for ClusterFutureBackend ... done [05:57:28.195] | : . ' eraseGlobalEnvironment() ... [05:57:28.196] | : . ' eraseGlobalEnvironment() ... done [05:57:28.196] | : . ' launchFuture() ... [05:57:28.196] | : . ' , cluster node index: 1 [05:57:28.197] | : . ' , getFutureData() ... [05:57:28.197] | : . ' , ; getFutureCore() ... [05:57:28.197] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:28.197] | : . ' , ; getFutureCore() ... done [05:57:28.198] | : . ' , ; getFutureCapture() ... [05:57:28.198] | : . ' , ; getFutureCapture() ... done [05:57:28.198] | : . ' , ; getFutureContext() ... [05:57:28.198] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:28.199] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:28.199] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:28.199] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:28.200] | : . ' , ; getFutureContext() ... done [05:57:28.200] | : . ' , getFutureData() ... done [05:57:28.201] | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... [05:57:28.201] | : . ' , ; Appended future to position #1 [05:57:28.202] | : . ' , ; Number of registered futures: 1 [05:57:28.202] | : . ' , FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'add', earlySignal = 0) ... done [05:57:28.202] | : . ' launchFuture() ... done [05:57:28.202] | : . ' ClusterFuture started [05:57:28.203] | : . Launching futures ... done [05:57:28.203] | : Using ClusterFutureBackend ... done [05:57:28.203] | : Future launched: 'ClusterFuture', 'MultiprocessFuture', 'Future' [05:57:28.203] | run() for 'Future' () ... done [05:57:28.204] future(..., label = NULL) ... done [05:57:28.204] value() for list ... [05:57:28.204] | recursive: 0 [05:57:28.205] | reduce: FALSE [05:57:28.205] | length: 2 [05:57:28.205] | Number of remaining objects: 2 [05:57:28.206] | checking value #1: [05:57:28.206] | 'obj' is ClusterFuture [05:57:28.206] | ClusterFuture #1 [05:57:28.207] | signalConditionsASAP(ClusterFuture, pos=1) ... [05:57:28.207] | : nx: 2 [05:57:28.207] | : relay: TRUE [05:57:28.207] | : stdout: TRUE [05:57:28.208] | : signal: TRUE [05:57:28.208] | : resignal: FALSE [05:57:28.208] | : force: TRUE [05:57:28.208] | : relayed: [n=2] FALSE, FALSE [05:57:28.209] | : queued futures: [n=2] FALSE, FALSE [05:57:28.209] | : until=1 [05:57:28.209] | : relaying element #1 [05:57:28.209] | : value() for ClusterFuture () ... [05:57:28.210] | : . result() for ClusterFuture ... [05:57:28.210] | : . ' result already collected: FutureResult [05:57:28.210] | : . result() for ClusterFuture ... done [05:57:28.210] | : . result() for ClusterFuture ... [05:57:28.211] | : . ' result already collected: FutureResult [05:57:28.211] | : . result() for ClusterFuture ... done [05:57:28.211] | : . signalConditions() ... [05:57:28.212] | : . ' include = 'immediateCondition' [05:57:28.212] | : . ' exclude = [05:57:28.212] | : . ' resignal = FALSE [05:57:28.212] | : . ' Number of conditions: 0 [05:57:28.213] | : . ' int 0 [05:57:28.216] | : . signalConditions() ... done [05:57:28.216] | : . relay stdout ... [05:57:28.216] | : . relay stdout ... done [05:57:28.216] | : . check for misuse ... [05:57:28.216] | : . check for misuse ... done [05:57:28.217] | : value() for ClusterFuture () ... done [05:57:28.217] | : result() for ClusterFuture ... [05:57:28.217] | : . result already collected: FutureResult [05:57:28.217] | : result() for ClusterFuture ... done [05:57:28.217] | : signalConditions() ... [05:57:28.217] | : . include = 'immediateCondition' [05:57:28.217] | : . exclude = [05:57:28.218] | : . resignal = FALSE [05:57:28.218] | : . Number of conditions: 0 [05:57:28.218] | : . int 0 [05:57:28.218] | : signalConditions() ... done [05:57:28.219] | : result() for ClusterFuture ... [05:57:28.219] | : . result already collected: FutureResult [05:57:28.219] | : result() for ClusterFuture ... done [05:57:28.219] | : signalConditions() ... [05:57:28.219] | : . include = 'condition' [05:57:28.219] | : . exclude = 'error', 'immediateCondition' [05:57:28.220] | : . resignal = TRUE [05:57:28.220] | : . Number of conditions: 0 [05:57:28.220] | : . int 0 [05:57:28.220] | : signalConditions() ... done [05:57:28.221] | : relayed: [n=2] TRUE, FALSE [05:57:28.221] | : queued futures: [n=2] TRUE, FALSE [05:57:28.221] | signalConditionsASAP(ClusterFuture, pos=1) ... done [05:57:28.221] | value(, ...) ... [05:57:28.221] | value(, ...) ... done [05:57:28.221] | value() for ClusterFuture () ... [05:57:28.221] | : result() for ClusterFuture ... [05:57:28.222] | : . result already collected: FutureResult [05:57:28.222] | : result() for ClusterFuture ... done [05:57:28.222] | : result() for ClusterFuture ... [05:57:28.222] | : . result already collected: FutureResult [05:57:28.222] | : result() for ClusterFuture ... done [05:57:28.222] | : signalConditions() ... [05:57:28.223] | : . include = 'immediateCondition' [05:57:28.223] | : . exclude = [05:57:28.223] | : . resignal = FALSE [05:57:28.223] | : . Number of conditions: 0 [05:57:28.223] | : . int 0 [05:57:28.224] | : signalConditions() ... done [05:57:28.224] | : check for misuse ... [05:57:28.224] | : check for misuse ... done [05:57:28.224] | value() for ClusterFuture () ... done [05:57:28.224] | value: [05:57:28.224] | signalConditionsASAP(ClusterFuture, pos=1) ... [05:57:28.225] | : nx: 2 [05:57:28.225] | : relay: TRUE [05:57:28.225] | : stdout: TRUE [05:57:28.225] | : signal: TRUE [05:57:28.225] | : resignal: FALSE [05:57:28.225] | : force: TRUE [05:57:28.225] | : relayed: [n=2] TRUE, FALSE [05:57:28.226] | : queued futures: [n=2] TRUE, FALSE [05:57:28.226] | : until=2 [05:57:28.226] | : relaying element #2 [05:57:28.226] | : relayed: [n=2] TRUE, FALSE [05:57:28.226] | : queued futures: [n=2] TRUE, FALSE [05:57:28.226] | signalConditionsASAP(ClusterFuture, pos=1) ... done [05:57:28.227] | resolve() for ClusterFuture ... [05:57:28.227] | resolve() for ClusterFuture ... done [05:57:28.227] | length: 1 (resolved future 1) [05:57:28.227] value() for list ... done [05:57:28.227] checking value #2: [05:57:28.227] 'obj' is ClusterFuture [05:57:28.228] resolved() for ClusterFuture () ... [05:57:28.228] | Cluster node socket connection: index=4, id=219 [05:57:28.228] | assertValidConnection() ... [05:57:28.228] | : cluster node index: 1 [05:57:28.229] | assertValidConnection() ... done [05:57:28.229] | receiveMessageFromWorker() for ClusterFuture ... [05:57:28.229] | : cluster node index: 1 [05:57:28.229] | : [1] TRUE [05:57:28.230] | : received data: [05:57:28.230] | : List of 5 [05:57:28.230] | : $ type : chr "VALUE" [05:57:28.230] | : $ value :List of 16 [05:57:28.230] | : ..$ value : int 2 [05:57:28.230] | : ..$ visible : logi TRUE [05:57:28.230] | : ..$ stdout : chr "" [05:57:28.230] | : ..$ conditions : list() [05:57:28.230] | : ..$ rng : logi FALSE [05:57:28.230] | : ..$ seed : NULL [05:57:28.230] | : ..$ misuseGlobalEnv : NULL [05:57:28.230] | : ..$ misuseConnections :List of 3 [05:57:28.230] | : .. ..$ added : NULL [05:57:28.230] | : .. ..$ removed : NULL [05:57:28.230] | : .. ..$ replaced: NULL [05:57:28.230] | : ..$ misuseDevices : NULL [05:57:28.230] | : ..$ misuseDefaultDevice: list() [05:57:28.230] | : ..$ started : POSIXct[1:1], format: "2025-06-05 05:57:28" [05:57:28.230] | : ..$ finished : POSIXct[1:1], format: "2025-06-05 05:57:28" [05:57:28.230] | : ..$ uuid : chr [1:2] "e6fc8766d87d810603f2d8674725d8b6" "6" [05:57:28.230] | : ..$ session_uuid : chr "54c76b9fc393ac059bfce4a3621d4e21" [05:57:28.230] | : .. ..- attr(*, "source")=List of 5 [05:57:28.230] | : .. .. ..$ host : Named chr "CRANWIN3" [05:57:28.230] | : .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [05:57:28.230] | : .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:28.230] | : .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:28.230] | : .. .. ..$ pid : int 161132 [05:57:28.230] | : .. .. ..$ time : POSIXct[1:1], format: "2025-06-05 05:57:28" [05:57:28.230] | : .. .. ..$ random: int 2147483647 [05:57:28.230] | : ..$ r_info :List of 4 [05:57:28.230] | : .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [05:57:28.230] | : .. .. ..$ : int [1:3] 4 6 0 [05:57:28.230] | : .. ..$ os : chr "windows" [05:57:28.230] | : .. ..$ os_name : chr "Windows" [05:57:28.230] | : .. ..$ captures_utf8: logi TRUE [05:57:28.230] | : ..$ version : chr "1.8" [05:57:28.230] | : ..- attr(*, "class")= chr "FutureResult" [05:57:28.230] | : $ success: logi TRUE [05:57:28.230] | : $ time : 'proc_time' Named num [1:5] 0 0 0 NA NA [05:57:28.230] | : ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [05:57:28.230] | : $ tag : NULL [05:57:28.253] | : Received FutureResult [05:57:28.253] | : FutureResult: [05:57:28.253] | : value: 'integer' [05:57:28.253] | : visible: TRUE [05:57:28.253] | : stdout: character [05:57:28.253] | : conditions: [n = 0] [05:57:28.253] | : RNG used: FALSE [05:57:28.253] | : duration: 0.006186008 secs (started 2025-06-05 05:57:28.201578) [05:57:28.253] | : version: 1.8 [05:57:28.254] | : FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... [05:57:28.255] | : . Removed future from position #1 [05:57:28.255] | : . Number of registered futures: 0 [05:57:28.255] | : FutureRegistry('workers-37e5752128e4483a3ce8b7fda2d6c13d', action = 'remove', earlySignal = 0) ... done [05:57:28.256] | : Erased future from future backend [05:57:28.256] | : result() for ClusterFuture ... [05:57:28.256] | : . result already collected: FutureResult [05:57:28.257] | : result() for ClusterFuture ... done [05:57:28.257] | : signalConditions() ... [05:57:28.257] | : . include = 'immediateCondition' [05:57:28.257] | : . exclude = [05:57:28.258] | : . resignal = FALSE [05:57:28.258] | : . Number of conditions: 0 [05:57:28.258] | : . int 0 [05:57:28.259] | : signalConditions() ... done [05:57:28.260] | receiveMessageFromWorker() for ClusterFuture ... done [05:57:28.260] | receiveMessageFromWorker() returned object of class FutureResult; resolved [05:57:28.260] resolved() for ClusterFuture () ... done [05:57:28.260] assertFutureResult() ... [05:57:28.261] | Future uuid: e6fc8766d87d810603f2d8674725d8b6[05:57:28.261] | Future uuid: 6 [05:57:28.261] | identical; success [05:57:28.261] assertFutureResult() ... done [05:57:28.262] ClusterFuture #2 [05:57:28.262] signalConditionsASAP(ClusterFuture, pos=2) ... [05:57:28.262] | nx: 2 [05:57:28.262] | relay: TRUE [05:57:28.263] | stdout: TRUE [05:57:28.263] | signal: TRUE [05:57:28.263] | resignal: FALSE [05:57:28.263] | force: TRUE [05:57:28.264] | relayed: [n=2] TRUE, FALSE [05:57:28.264] | queued futures: [n=2] TRUE, FALSE [05:57:28.264] | until=2 [05:57:28.265] | relaying element #2 [05:57:28.265] | value() for ClusterFuture () ... [05:57:28.265] | : result() for ClusterFuture ... [05:57:28.265] | : . result already collected: FutureResult [05:57:28.266] | : result() for ClusterFuture ... done [05:57:28.266] | : result() for ClusterFuture ... [05:57:28.266] | : . result already collected: FutureResult [05:57:28.267] | : result() for ClusterFuture ... done [05:57:28.267] | : signalConditions() ... [05:57:28.267] | : . include = 'immediateCondition' [05:57:28.267] | : . exclude = [05:57:28.268] | : . resignal = FALSE [05:57:28.268] | : . Number of conditions: 0 [05:57:28.268] | : . int 0 [05:57:28.269] | : signalConditions() ... done [05:57:28.270] | : relay stdout ... [05:57:28.270] | : relay stdout ... done [05:57:28.270] | : check for misuse ... [05:57:28.271] | : check for misuse ... done [05:57:28.271] | value() for ClusterFuture () ... done [05:57:28.271] | result() for ClusterFuture ... [05:57:28.271] | : result already collected: FutureResult [05:57:28.272] | result() for ClusterFuture ... done [05:57:28.272] | signalConditions() ... [05:57:28.272] | : include = 'immediateCondition' [05:57:28.273] | : exclude = [05:57:28.273] | : resignal = FALSE [05:57:28.273] | : Number of conditions: 0 [05:57:28.273] | : int 0 [05:57:28.274] | signalConditions() ... done [05:57:28.275] | result() for ClusterFuture ... [05:57:28.275] | : result already collected: FutureResult [05:57:28.275] | result() for ClusterFuture ... done [05:57:28.275] | signalConditions() ... [05:57:28.276] | : include = 'condition' [05:57:28.276] | : exclude = 'error', 'immediateCondition' [05:57:28.276] | : resignal = TRUE [05:57:28.277] | : Number of conditions: 0 [05:57:28.277] | : int 0 [05:57:28.278] | signalConditions() ... done [05:57:28.278] | relayed: [n=2] TRUE, TRUE [05:57:28.278] | queued futures: [n=2] TRUE, TRUE [05:57:28.279] signalConditionsASAP(ClusterFuture, pos=2) ... done [05:57:28.279] value(, ...) ... [05:57:28.279] value(, ...) ... done [05:57:28.279] value() for ClusterFuture () ... [05:57:28.280] | result() for ClusterFuture ... [05:57:28.280] | : result already collected: FutureResult [05:57:28.280] | result() for ClusterFuture ... done [05:57:28.280] | result() for ClusterFuture ... [05:57:28.281] | : result already collected: FutureResult [05:57:28.281] | result() for ClusterFuture ... done [05:57:28.281] | signalConditions() ... [05:57:28.281] | : include = 'immediateCondition' [05:57:28.281] | : exclude = [05:57:28.282] | : resignal = FALSE [05:57:28.282] | : Number of conditions: 0 [05:57:28.282] | : int 0 [05:57:28.283] | signalConditions() ... done [05:57:28.283] | check for misuse ... [05:57:28.283] | check for misuse ... done [05:57:28.284] value() for ClusterFuture () ... done [05:57:28.284] value: [05:57:28.284] signalConditionsASAP(ClusterFuture, pos=2) ... [05:57:28.284] | nx: 2 [05:57:28.285] | relay: TRUE [05:57:28.285] | stdout: TRUE [05:57:28.285] | signal: TRUE [05:57:28.285] | resignal: FALSE [05:57:28.285] | force: TRUE [05:57:28.286] | relayed: [n=2] TRUE, TRUE [05:57:28.286] | queued futures: [n=2] TRUE, TRUE [05:57:28.286] | until=2 [05:57:28.286] | relayed: [n=2] TRUE, TRUE [05:57:28.287] | queued futures: [n=2] TRUE, TRUE [05:57:28.287] signalConditionsASAP(ClusterFuture, pos=2) ... done [05:57:28.287] resolve() for ClusterFuture ... [05:57:28.287] resolve() for ClusterFuture ... done [05:57:28.288] length: 0 (resolved future 2) [05:57:28.288] Relaying remaining futures ... [05:57:28.288] | signalConditionsASAP(NULL, pos=0) ... [05:57:28.289] | : nx: 2 [05:57:28.289] | : relay: TRUE [05:57:28.289] | : stdout: TRUE [05:57:28.289] | : signal: TRUE [05:57:28.289] | : resignal: FALSE [05:57:28.290] | : force: TRUE [05:57:28.290] | : relayed: [n=2] TRUE, TRUE [05:57:28.290] | : queued futures: [n=2] TRUE, TRUE - flush all [05:57:28.290] | : relayed: [n=2] TRUE, TRUE [05:57:28.291] | : queued futures: [n=2] TRUE, TRUE [05:57:28.291] | signalConditionsASAP(NULL, pos=0) ... done [05:57:28.291] Relaying remaining futures ... done > plan(sequential) [05:57:28.297] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:28.297] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... [05:57:28.298] | : all.equal() for FutureStrategyList ... [05:57:28.298] | : . New stack: [05:57:28.298] | : . List of 1 [05:57:28.298] | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:28.298] | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:28.298] | : . ..- attr(*, "init")= logi TRUE [05:57:28.298] | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:28.298] | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.298] | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.298] | : . ..- attr(*, "call")= language plan(sequential) [05:57:28.298] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:28.302] | : . Old stack: [05:57:28.303] | : . List of 1 [05:57:28.303] | : . $ :function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:28.303] | : . envir = parent.frame()) [05:57:28.303] | : . ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:28.303] | : . ..- attr(*, "init")= chr "done" [05:57:28.303] | : . ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:28.303] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:28.303] | : . .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:28.303] | : . ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:28.303] | : . ..- attr(*, "tweaks")=List of 1 [05:57:28.303] | : . .. ..$ workers:List of 1 [05:57:28.303] | : . .. .. ..$ :List of 3 [05:57:28.303] | : . .. .. .. ..$ con : 'sockconn' int 4 [05:57:28.303] | : . .. .. .. .. ..- attr(*, "conn_id")= [05:57:28.303] | : . .. .. .. ..$ host: chr "localhost" [05:57:28.303] | : . .. .. .. ..$ rank: num 0 [05:57:28.303] | : . .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:28.303] | : . .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:28.303] | : . ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:28.303] | : . ..- attr(*, "backend")=Classes 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment' [05:57:28.303] | : . .. ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:28.303] | : . earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:28.303] | : . .. .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:28.303] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:28.313] | : . Not identical [05:57:28.313] | : . all.equal() for future ... [05:57:28.313] | : . ' List of 2 [05:57:28.313] | : . ' $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:28.313] | : . ' ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:28.313] | : . ' ..- attr(*, "init")= logi TRUE [05:57:28.313] | : . ' ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:28.313] | : . ' .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.313] | : . ' ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.313] | : . ' ..- attr(*, "call")= language plan(sequential) [05:57:28.313] | : . ' $ current:function (..., workers = list(list(con = 4L, host = "localhost", rank = 0)), [05:57:28.313] | : . ' envir = parent.frame()) [05:57:28.313] | : . ' ..- attr(*, "class")= chr [1:5] "tweaked" "cluster" "multiprocess" "future" ... [05:57:28.313] | : . ' ..- attr(*, "init")= chr "done" [05:57:28.313] | : . ' ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:28.313] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:28.313] | : . ' .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:28.313] | : . ' ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:28.313] | : . ' ..- attr(*, "tweaks")=List of 1 [05:57:28.313] | : . ' .. ..$ workers:List of 1 [05:57:28.313] | : . ' .. .. ..$ :List of 3 [05:57:28.313] | : . ' .. .. .. ..$ con : 'sockconn' int 4 [05:57:28.313] | : . ' .. .. .. .. ..- attr(*, "conn_id")= [05:57:28.313] | : . ' .. .. .. ..$ host: chr "localhost" [05:57:28.313] | : . ' .. .. .. ..$ rank: num 0 [05:57:28.313] | : . ' .. .. .. ..- attr(*, "class")= chr "SOCKnode" [05:57:28.313] | : . ' .. .. ..- attr(*, "class")= chr [1:2] "SOCKcluster" "cluster" [05:57:28.313] | : . ' ..- attr(*, "call")= language plan(cluster, workers = cl) [05:57:28.313] | : . ' ..- attr(*, "backend")=Classes 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment' [05:57:28.313] | : . ' .. ..- attr(*, "factory")=function (workers = availableWorkers(constraints = "connections"), gc = TRUE, [05:57:28.313] | : . ' earlySignal = TRUE, interrupts = FALSE, persistent = FALSE, ...) [05:57:28.313] | : . ' .. .. ..- attr(*, "tweakable")= chr [1:9] "gc" "earlySignal" "interrupts" "persistent" ... [05:57:28.327] | : . ' Formals differ [05:57:28.327] | : . all.equal() for future ... done [05:57:28.327] | : . Future strategies differ at level 1 [05:57:28.327] | : all.equal() for FutureStrategyList ... done [05:57:28.328] | : plan(): Setting new future backend stack: [05:57:28.328] | : List of future strategies: [05:57:28.328] | : 1. sequential: [05:57:28.328] | : - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:28.328] | : - tweaked: FALSE [05:57:28.328] | : - call: plan(sequential) [05:57:28.329] | : List of 1 [05:57:28.329] | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:28.329] | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:28.329] | : ..- attr(*, "init")= logi TRUE [05:57:28.329] | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:28.329] | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.329] | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.329] | : ..- attr(*, "call")= language plan(sequential) [05:57:28.329] | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:28.333] | : plan(): plan_cleanup('tweaked', 'cluster', 'multiprocess', 'future', 'function', cleanup = NA) ... [05:57:28.333] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:28.333] | : . ' Getting current ("next") strategy: 'FutureStrategy', 'tweaked', 'cluster', 'multiprocess', 'future', 'function' [05:57:28.334] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:28.334] | : . stopWorkers() for ClusterFutureBackend ... [05:57:28.334] | : . ' Interrupt active futures ... [05:57:28.335] | : . ' , Number of futures: 0 [05:57:28.335] | : . ' Interrupt active futures ... done [05:57:28.335] | : . ' Clear future registry ... [05:57:28.336] | : . ' Clear future registry ... done [05:57:28.336] | : . ' Stop cluster workers ... [05:57:28.336] | : . ' , Stopping existing cluster ... [05:57:28.337] | : . ' , ; No pre-existing cluster. Skipping [05:57:28.337] | : . ' , Stopping existing cluster ... done [05:57:28.337] | : . ' Stop cluster workers ... done [05:57:28.337] | : . stopWorkers() for ClusterFutureBackend ... done [05:57:28.337] | : . Legacy shutdown of cluster workers ... [05:57:28.338] | : . ' Stopping existing cluster ... [05:57:28.338] | : . ' , No pre-existing cluster. Skipping [05:57:28.338] | : . ' Stopping existing cluster ... done [05:57:28.338] | : . Legacy shutdown of cluster workers ... done [05:57:28.339] | : plan(): plan_cleanup('tweaked', 'cluster', 'multiprocess', 'future', 'function', cleanup = NA) ... done [05:57:28.339] | : plan(): plan_init() of 'sequential', 'uniprocess', 'future', 'function' ... [05:57:28.339] | : . function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:28.339] | : . - attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:28.339] | : . - attr(*, "init")= logi TRUE [05:57:28.339] | : . - attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:28.339] | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.339] | : . - attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:28.339] | : . - attr(*, "call")= language plan(sequential) [05:57:28.342] | : . init: TRUE [05:57:28.343] | : . makeFutureBackend() ... [05:57:28.343] | : . ' Backend function: <'NULL'> [05:57:28.343] | : . ' Evaluator tweak arguments: [n=0] [05:57:28.343] | : . ' list() [05:57:28.344] | : . ' Evaluator formal arguments: [n=2] [05:57:28.344] | : . ' list() [05:57:28.344] | : . ' Backend factory arguments: [n=2] [05:57:28.345] | : . ' Dotted pair list of 2 [05:57:28.345] | : . ' $ gc : logi FALSE [05:57:28.345] | : . ' $ earlySignal: logi FALSE [05:57:28.346] | : . ' Backend: <'SequentialFutureBackend', 'FutureBackend', 'environment'> [05:57:28.347] | : . makeFutureBackend() ... done [05:57:28.347] | : plan(): plan_init() of 'sequential', 'uniprocess', 'future', 'function' ... done [05:57:28.347] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:28.347] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:28.348] | : plan(): nbrOfWorkers() = 1 [05:57:28.348] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done [05:57:28.348] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done > message("all.equal() for cluster backend ... done") all.equal() for cluster backend ... done Sourcing 6 epilogue scripts ... 01/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/001.undo-future.R' 02/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/002.undo-state.R' Failed to undo environment variables: - Expected environment variables: [n=213] '!ExitCode', 'ALLUSERSPROFILE', 'APPDATA', 'BIBINPUTS', 'BINDIR', 'BSTINPUTS', 'COMMONPROGRAMFILES', 'COMPUTERNAME', 'COMSPEC', 'CURL_CA_BUNDLE', 'CYGWIN', 'CommonProgramFiles(x86)', 'CommonProgramW6432', 'DriverData', 'HOME', 'HOMEDRIVE', 'HOMEPATH', 'JAGS_ROOT', 'JAVA_HOME', 'LANGUAGE', 'LC_COLLATE', 'LC_MONETARY', 'LC_TIME', 'LOCALAPPDATA', 'LOGONSERVER', 'LS_HOME', 'LS_LICENSE_PATH', 'MAKE', 'MAKEFLAGS', 'MAKELEVEL', 'MFLAGS', 'MSMPI_BENCHMARKS', 'MSMPI_BIN', 'MSYS2_ENV_CONV_EXCL', 'NUMBER_OF_PROCESSORS', 'OCL', 'OMP_THREAD_LIMIT', 'OS', 'PATH', 'PATHEXT', 'PROCESSOR_ARCHITECTURE', 'PROCESSOR_IDENTIFIER', 'PROCESSOR_LEVEL', 'PROCESSOR_REVISION', 'PROGRAMFILES', 'PROMPT', 'PSModulePath', 'PUBLIC', 'PWD', 'ProgramData', 'ProgramFiles(x86)', 'ProgramW6432', 'RTOOLS44_HOME', 'RTOOLS45_HOME', 'R_ARCH', 'R_BROWSER', 'R_BZIPCMD', 'R_CMD', 'R_COMPILED_BY', 'R_CRAN_WEB', 'R_CUSTOM_TOOLS_PATH', 'R_CUSTOM_TOOLS_SOFT', 'R_DOC_DIR', 'R_ENVIRON_USER', 'R_GSCMD', 'R_GZIPCMD', 'R_HOME', 'R_INCLUDE_DIR', 'R_INSTALL_TAR', 'R_LIBS', 'R_LIBS_SITE', 'R_LIBS_USER', 'R_MAX_NUM_DLLS', 'R_OSTYPE', 'R_PAPERSIZE', 'R_PAPERSIZE_USER', 'R_PARALLELLY_MAKENODEPSOCK_AUTOKILL', 'R_PARALLELLY_MAKENODEPSOCK_CONNECTTIMEOUT', 'R_PARALLELLY_MAKENODEPSOCK_RSCRIPT_LABEL', 'R_PARALLELLY_MAKENODEPSOCK_SESSIONINFO_PKGS', 'R_PARALLELLY_MAKENODEPSOCK_TIMEOUT', 'R_PARALLELLY_RANDOM_PORTS', 'R_PARALLEL_PORT', 'R_RD4PDF', 'R_RTOOLS45_PATH', 'R_SCRIPT_LEGACY', 'R_SHARE_DIR', 'R_TESTME_NAME', 'R_TESTME_PACKAGE', 'R_TESTME_PATH', 'R_TESTS', 'R_UNZIPCMD', 'R_USER', 'R_VERSION', 'R_ZIPCMD', 'SED', 'SHLVL', 'SYSTEMDRIVE', 'SYSTEMROOT', 'TAR', 'TAR_OPTIONS', 'TEMP', 'TERM', 'TEXINPUTS', 'TMP', 'TMPDIR', 'USERDOMAIN', 'USERDOMAIN_ROAMINGPROFILE', 'USERNAME', 'USERPROFILE', 'WINDIR', '_', '_R_CHECK_AUTOCONF_', '_R_CHECK_BOGUS_RETURN_', '_R_CHECK_BROWSER_NONINTERACTIVE_', '_R_CHECK_BUILD_VIGNETTES_SEPARATELY_', '_R_CHECK_CODETOOLS_PROFILE_', '_R_CHECK_CODE_ASSIGN_TO_GLOBALENV_', '_R_CHECK_CODE_ATTACH_', '_R_CHECK_CODE_CLASS_IS_STRING_', '_R_CHECK_CODE_DATA_INTO_GLOBALENV_', '_R_CHECK_CODE_USAGE_VIA_NAMESPACES_', '_R_CHECK_CODE_USAGE_WITHOUT_LOADING_', '_R_CHECK_CODE_USAGE_WITH_ONLY_BASE_ATTACHED_', '_R_CHECK_CODOC_VARIABLES_IN_USAGES_', '_R_CHECK_COMPACT_DATA2_', '_R_CHECK_COMPILATION_FLAGS_', '_R_CHECK_CONNECTIONS_LEFT_OPEN_', '_R_CHECK_CRAN_INCOMING_', '_R_CHECK_CRAN_INCOMING_ASPELL_RECHECK_MAYBE_', '_R_CHECK_CRAN_INCOMING_ASPELL_RECHECK_START_', '_R_CHECK_CRAN_INCOMING_CHECK_FILE_URIS_', '_R_CHECK_CRAN_INCOMING_CHECK_URLS_IN_PARALLEL_', '_R_CHECK_CRAN_INCOMING_NOTE_GNU_MAKE_', '_R_CHECK_CRAN_INCOMING_REMOTE_', '_R_CHECK_CRAN_INCOMING_USE_ASPELL_', '_R_CHECK_DATALIST_', '_R_CHECK_DEPRECATED_DEFUNCT_', '_R_CHECK_DOC_SIZES2_', '_R_CHECK_DOT_FIRSTLIB_', '_R_CHECK_DOT_INTERNAL_', '_R_CHECK_EXAMPLE_TIMING_THRESHOLD_', '_R_CHECK_EXECUTABLES_', '_R_CHECK_EXECUTABLES_EXCLUSIONS_', '_R_CHECK_FF_CALLS_', '_R_CHECK_FF_DUP_', '_R_CHECK_FORCE_SUGGESTS_', '_R_CHECK_FUTURE_FILE_TIMESTAMPS_', '_R_CHECK_FUTURE_FILE_TIMESTAMPS_LEEWAY_', '_R_CHECK_HAVE_MYSQL_', '_R_CHECK_HAVE_ODBC_', '_R_CHECK_HAVE_PERL_', '_R_CHECK_HAVE_POSTGRES_', '_R_CHECK_INSTALL_DEPENDS_', '_R_CHECK_INTERNALS2_', '_R_CHECK_LENGTH_1_CONDITION_', '_R_CHECK_LICENSE_', '_R_CHECK_LIMIT_CORES_', '_R_CHECK_LOG_USE_INFO_', '_R_CHECK_MATRIX_DATA_', '_R_CHECK_MBCS_CONVERSION_FAILURE_', '_R_CHECK_NATIVE_ROUTINE_REGISTRATION_', '_R_CHECK_NEWS_IN_PLAIN_TEXT_', '_R_CHECK_NO_RECOMMENDED_', '_R_CHECK_NO_STOP_ON_TEST_ERROR_', '_R_CHECK_ORPHANED_', '_R_CHECK_OVERWRITE_REGISTERED_S3_METHODS_', '_R_CHECK_PACKAGES_USED_IGNORE_UNUSED_IMPORTS_', '_R_CHECK_PACKAGES_USED_IN_TESTS_USE_SUBDIRS_', '_R_CHECK_PACKAGE_DATASETS_SUPPRESS_NOTES_', '_R_CHECK_PACKAGE_NAME_', '_R_CHECK_PKG_SIZES_', '_R_CHECK_PKG_SIZES_THRESHOLD_', '_R_CHECK_PRAGMAS_', '_R_CHECK_RD_EXAMPLES_T_AND_F_', '_R_CHECK_RD_LINE_WIDTHS_', '_R_CHECK_RD_MATH_RENDERING_', '_R_CHECK_RD_NOTE_LOST_BRACES_', '_R_CHECK_RD_VALIDATE_RD2HTML_', '_R_CHECK_REPLACING_IMPORTS_', '_R_CHECK_R_DEPENDS_', '_R_CHECK_S3_METHODS_SHOW_POSSIBLE_ISSUES_', '_R_CHECK_SCREEN_DEVICE_', '_R_CHECK_SERIALIZATION_', '_R_CHECK_SHLIB_OPENMP_FLAGS_', '_R_CHECK_SRC_MINUS_W_IMPLICIT_', '_R_CHECK_SUBDIRS_NOCASE_', '_R_CHECK_SUGGESTS_ONLY_', '_R_CHECK_SYSTEM_CLOCK_', '_R_CHECK_TESTS_NLINES_', '_R_CHECK_TEST_TIMING_', '_R_CHECK_TIMINGS_', '_R_CHECK_TOPLEVEL_FILES_', '_R_CHECK_UNDOC_USE_ALL_NAMES_', '_R_CHECK_UNSAFE_CALLS_', '_R_CHECK_URLS_SHOW_301_STATUS_', '_R_CHECK_VC_DIRS_', '_R_CHECK_VIGNETTES_NLINES_', '_R_CHECK_VIGNETTES_SKIP_RUN_MAYBE_', '_R_CHECK_VIGNETTE_TIMING_', '_R_CHECK_VIGNETTE_TITLES_', '_R_CHECK_WINDOWS_DEVICE_', '_R_CHECK_XREFS_NOTE_MISSING_PACKAGE_ANCHORS_', '_R_CHECK_XREFS_USE_ALIASES_FROM_CRAN_', '_R_CLASS_MATRIX_ARRAY_', '_R_DEPRECATED_IS_R_', '_R_S3_METHOD_LOOKUP_BASEENV_AFTER_GLOBALENV_', '_R_SHLIB_BUILD_OBJECTS_SYMBOL_TABLES_', '_R_USE_STRICT_R_HEADERS_', '__R_CHECK_DOC_FILES_NOTE_IF_ALL_SPECIAL__', 'maj.version', 'nextArg--timingsnextArg--install', 'tempdirname' - Environment variables still there: [n=0] - Environment variables missing: [n=1] 'MAKEFLAGS' Differences environment variable by environment variable: 03/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/090.gc.R' 04/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/099.session_info.R' 05/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/995.detritus-connections.R' 06/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/999.detritus-files.R' Skipping, because path appears not to be an 'R CMD check' folder: 'D:/temp/2025_06_05_05_55_16_20588' Sourcing 6 epilogue scripts ... done Test time: user.self=1s, sys.self=0.02s, elapsed=3s, user.child=NAs, sys.child=NAs Test 'cluster-connection-clashes' ... success > > proc.time() user system elapsed 1.60 0.17 3.15