R Under development (unstable) (2025-05-08 r88190 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-globals,resolve.R
> ## Don't edit - it was autogenerated by inst/testme/deploy.R
> future:::testme("globals,resolve")
Test 'globals,resolve' ...
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-globals,resolve.R'

> library(future)
[01:57:38.839] Option 'future.startup.script': TRUE
[01:57:38.840] Future startup scripts considered: '.future.R', '~/.future.R'
[01:57:38.841] Future startup scripts found: <none>

> library(listenv)

> oopts <- c(oopts, options(future.globals.resolve = TRUE))

> setTimeLimit(cpu = 10, elapsed = 10, transient = TRUE)

> message("*** Tricky use cases related to globals (part 2) ...")
*** Tricky use cases related to globals (part 2) ...

> plan(multisession, workers = 2)
[01:57:38.847] plan(<name>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:38.848] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ...
[01:57:38.848] | : all.equal() for FutureStrategyList ...
[01:57:38.848] | : . New stack:
[01:57:38.849] | : . List of 1
[01:57:38.849] | : .  $ :function (..., workers = 2L, envir = parent.frame())  
[01:57:38.849] | : .   ..- attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ...
[01:57:38.849] | : .   ..- attr(*, "init")= logi TRUE
[01:57:38.849] | : .   ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:57:38.849] | : .     gc = FALSE, earlySignal = FALSE, ...)  
[01:57:38.849] | : .   .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.849] | : .   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.849] | : .   ..- attr(*, "untweakable")= chr "persistent"
[01:57:38.849] | : .   ..- attr(*, "tweaks")=List of 1
[01:57:38.849] | : .   .. ..$ workers: int 2
[01:57:38.849] | : .   ..- attr(*, "call")= language plan(multisession, workers = 2L)
[01:57:38.849] | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:57:38.855] | : . Old stack:
[01:57:38.855] | : . List of 1
[01:57:38.855] | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:57:38.855] | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:57:38.855] | : .   ..- attr(*, "init")= logi TRUE
[01:57:38.855] | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:57:38.855] | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:57:38.855] | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:57:38.855] | : .   ..- attr(*, "call")= language plan(sequential)
[01:57:38.855] | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:57:38.859] | : . Not identical
[01:57:38.859] | : . all.equal() for future ...
[01:57:38.859] | : . ' List of 2
[01:57:38.859] | : . '  $ target :function (..., workers = 2L, envir = parent.frame())  
[01:57:38.859] | : . '   ..- attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ...
[01:57:38.859] | : . '   ..- attr(*, "init")= logi TRUE
[01:57:38.859] | : . '   ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:57:38.859] | : . '     gc = FALSE, earlySignal = FALSE, ...)  
[01:57:38.859] | : . '   .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.859] | : . '   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.859] | : . '   ..- attr(*, "untweakable")= chr "persistent"
[01:57:38.859] | : . '   ..- attr(*, "tweaks")=List of 1
[01:57:38.859] | : . '   .. ..$ workers: int 2
[01:57:38.859] | : . '   ..- attr(*, "call")= language plan(multisession, workers = 2L)
[01:57:38.859] | : . '  $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:57:38.859] | : . '   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:57:38.859] | : . '   ..- attr(*, "init")= logi TRUE
[01:57:38.859] | : . '   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:57:38.859] | : . '   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:57:38.859] | : . '   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:57:38.859] | : . '   ..- attr(*, "call")= language plan(sequential)
[01:57:38.868] | : . ' Formals differ
[01:57:38.868] | : . all.equal() for future ... done
[01:57:38.868] | : . Future strategies differ at level 1
[01:57:38.868] | : all.equal() for FutureStrategyList ... done
[01:57:38.868] | : plan(): Setting new future backend stack:
[01:57:38.869] | : List of future strategies:
[01:57:38.869] | : 1. multisession:
[01:57:38.869] | :    - args: function (..., workers = 2L, envir = parent.frame())
[01:57:38.869] | :    - tweaked: TRUE
[01:57:38.869] | :    - call: plan(multisession, workers = 2L)
[01:57:38.869] | : List of 1
[01:57:38.869] | :  $ :function (..., workers = 2L, envir = parent.frame())  
[01:57:38.869] | :   ..- attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ...
[01:57:38.869] | :   ..- attr(*, "init")= logi TRUE
[01:57:38.869] | :   ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:57:38.869] | :     gc = FALSE, earlySignal = FALSE, ...)  
[01:57:38.869] | :   .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.869] | :   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.869] | :   ..- attr(*, "untweakable")= chr "persistent"
[01:57:38.869] | :   ..- attr(*, "tweaks")=List of 1
[01:57:38.869] | :   .. ..$ workers: int 2
[01:57:38.869] | :   ..- attr(*, "call")= language plan(multisession, workers = 2L)
[01:57:38.869] | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:57:38.873] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ...
[01:57:38.874] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:38.874] | : . ' Getting current ("next") strategy: 'FutureStrategy', 'sequential', 'uniprocess', 'future', 'function'
[01:57:38.874] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:38.874] | : . Legacy shutdown of cluster workers ...
[01:57:38.875] | : . ' Stopping existing cluster ...
[01:57:38.875] | : . ' , No pre-existing cluster. Skipping
[01:57:38.875] | : . ' Stopping existing cluster ... done
[01:57:38.875] | : . Legacy shutdown of cluster workers ... done
[01:57:38.875] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... done
[01:57:38.875] | : plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ...
[01:57:38.876] | : . function (..., workers = 2L, envir = parent.frame())  
[01:57:38.876] | : .  - attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ...
[01:57:38.876] | : .  - attr(*, "init")= logi TRUE
[01:57:38.876] | : .  - attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:57:38.876] | : .     gc = FALSE, earlySignal = FALSE, ...)  
[01:57:38.876] | : .   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.876] | : .  - attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:57:38.876] | : .  - attr(*, "untweakable")= chr "persistent"
[01:57:38.876] | : .  - attr(*, "tweaks")=List of 1
[01:57:38.876] | : .   ..$ workers: int 2
[01:57:38.876] | : .  - attr(*, "call")= language plan(multisession, workers = 2L)
[01:57:38.879] | : . init: TRUE
[01:57:38.879] | : . makeFutureBackend(<tweaked>) ...
[01:57:38.880] | : . ' Backend function: <'NULL'>
[01:57:38.880] | : . ' Evaluator tweak arguments: [n=1]
[01:57:38.880] | : . ' List of 1
[01:57:38.880] | : . '  $ workers: int 2
[01:57:38.881] | : . ' Evaluator formal arguments: [n=1]
[01:57:38.881] | : . ' List of 1
[01:57:38.881] | : . '  $ workers: int 2
[01:57:38.882] | : . ' Backend factory arguments: [n=1]
[01:57:38.882] | : . ' Dotted pair list of 1
[01:57:38.882] | : . '  $ workers: int 2
[01:57:38.883] | : . ' MultisessionFutureBackend(workers = <workers>, interrupts = TRUE, ...) ...
[01:57:38.883] | : . ' , Arguments:
[01:57:38.883] | : . ' , List of 5
[01:57:38.883] | : . ' ,  $ workers     : int 2
[01:57:38.883] | : . ' ,  $ rscript_libs: chr [1:2] "D:/temp/2025_05_09_01_55_17_23336/RtmpsDakIT/RLIBS_1b6487de1dd0" "D:/RCompile/recent/R/library"
[01:57:38.883] | : . ' ,  $ interrupts  : logi TRUE
[01:57:38.883] | : . ' ,  $ gc          : logi FALSE
[01:57:38.883] | : . ' ,  $ earlySignal : logi FALSE
[01:57:38.885] | : . ' , ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ...
[01:57:38.886] | : . ' , ; workers: 2
[01:57:38.886] | : . ' , ; getCluster() ...
[01:57:38.886] | : . ' , ; getCluster() ... done
[01:57:38.886] | : . ' , ; Stopping existing cluster ...
[01:57:38.886] | : . ' , ; ` No pre-existing cluster. Skipping
[01:57:38.886] | : . ' , ; Stopping existing cluster ... done
[01:57:38.887] | : . ' , ; Starting new cluster ...
[01:57:38.887] | : . ' , ; ` makeCluster(workers, ...) ...
[01:57:38.887] | : . ' , ; ` | Arguments:
[01:57:38.887] | : . ' , ; ` | List of 2
[01:57:38.887] | : . ' , ; ` |  $             : int 2
[01:57:38.887] | : . ' , ; ` |  $ rscript_libs: chr [1:2] "D:/temp/2025_05_09_01_55_17_23336/RtmpsDakIT/RLIBS_1b6487de1dd0" "D:/RCompile/recent/R/library"
[01:57:38.889] | : . ' , ; ` | .makeCluster() ...
[01:57:38.890] | : . ' , ; ` | : workers: '2'
[01:57:38.890] | : . ' , ; ` | : R_FUTURE_PLAN: NA
[01:57:38.890] | : . ' , ; ` | : parallelly::makeClusterPSOCK() arguments:
[01:57:38.891] | : . ' , ; ` | : List of 2
[01:57:38.891] | : . ' , ; ` | :  $             : int 2
[01:57:38.891] | : . ' , ; ` | :  $ rscript_libs: chr [1:2] "D:/temp/2025_05_09_01_55_17_23336/RtmpsDakIT/RLIBS_1b6487de1dd0" "D:/RCompile/recent/R/library"
[01:57:39.405] | : . ' , ; ` | : Generated cluster UUID
[01:57:39.405] | : . ' , ; ` | : Cluster UUID: 'ae95f3500835a0ac9cf9c52acb33ee0e'
[01:57:39.406] | : . ' , ; ` | : Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-05-08 r88190 ucrt), platform x86_64-w64-mingw32)
[01:57:39.409] | : . ' , ; ` | .makeCluster() ... done
[01:57:39.409] | : . ' , ; ` | Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-05-08 r88190 ucrt), platform x86_64-w64-mingw32)
[01:57:39.411] | : . ' , ; ` makeCluster(workers, ...) ... done
[01:57:39.411] | : . ' , ; ` Number of workers: 2
[01:57:39.411] | : . ' , ; ` Workers UUID: 'ae95f3500835a0ac9cf9c52acb33ee0e'
[01:57:39.412] | : . ' , ; Starting new cluster ... done
[01:57:39.412] | : . ' , ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ... done
[01:57:39.412] | : . ' , Backend: <'MultisessionFutureBackend', 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment'>
[01:57:39.412] | : . ' MultisessionFutureBackend(workers = <workers>, interrupts = TRUE, ...) ... done
[01:57:39.413] | : . makeFutureBackend(<tweaked>) ... done
[01:57:39.413] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.413] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.413] | : . plan(): nbrOfWorkers() = 2
[01:57:39.414] | : plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... done
[01:57:39.414] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done

> env <- new.env()

> env$a %<-% {
+     5
+ }
[01:57:39.415] | future(..., label = NULL) ...
[01:57:39.415] | : lazy: FALSE
[01:57:39.415] | : stdout: TRUE
[01:57:39.416] | : conditions: [n=1] 'condition'
[01:57:39.416] | : gc: FALSE
[01:57:39.416] | : earlySignal: FALSE
Warning in getGlobalsAndPackages(expr, envir = envir, tweak = tweakExpression,  :
  R option 'future.globals.resolve' may only be used for troubleshooting. It must not be used in production since it changes how futures are evaluated and there is a great risk that the results cannot be reproduced elsewhere: 'TRUE'
[01:57:39.417] | : getGlobalsAndPackages() ...
[01:57:39.417] | : . Searching for globals ...
[01:57:39.430] | : . ' globals found: [1] '{'
[01:57:39.430] | : . Searching for globals ... done
[01:57:39.431] | : . Resolving globals: TRUE
[01:57:39.431] | : . Resolving any globals that are futures ...
[01:57:39.431] | : . ' globals: [1] '{'
[01:57:39.431] | : . Resolving any globals that are futures ... done
[01:57:39.431] | : . Search for packages associated with the globals ...
[01:57:39.432] | : . ' Packages associated with globals: [1] 'base'
[01:57:39.432] | : . ' Packages: [1] 'base'
[01:57:39.433] | : . Search for packages associated with the globals ... done
[01:57:39.433] | : . Packages after dropping 'base': [0] 
[01:57:39.433] | : . globals: [0] 
[01:57:39.433] | : . packages: [0] 
[01:57:39.433] | : getGlobalsAndPackages() ... done
[01:57:39.434] | : run() for 'Future' (NULL) ...
[01:57:39.435] | : . state: 'created'
[01:57:39.435] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.435] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.435] | : . Using MultisessionFutureBackend ...
[01:57:39.436] | : . ' Number of futures since start: 0 (0 created, 0 launched, 0 finished)
[01:57:39.436] | : . ' Launching futures ...
[01:57:39.436] | : . ' , launchFuture() for ClusterFutureBackend ...
[01:57:39.437] | : . ' , ; Workers: [n=2]
[01:57:39.437] | : . ' , ; Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-05-08 r88190 ucrt), platform x86_64-w64-mingw32)
[01:57:39.439] | : . ' , ; FutureRegistry: 'workers-ae95f3500835a0ac9cf9c52acb33ee0e'
[01:57:39.439] | : . ' , ; requestWorker() ...
[01:57:39.440] | : . ' , ; ` requestNode() ...
[01:57:39.440] | : . ' , ; ` | Number of workers: 2
[01:57:39.440] | : . ' , ; ` | Polling for a free worker ...
[01:57:39.440] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.440] | : . ' , ; ` | : . Created empty registry 'workers-ae95f3500835a0ac9cf9c52acb33ee0e'
[01:57:39.441] | : . ' , ; ` | : . Listing all futures
[01:57:39.441] | : . ' , ; ` | : . Number of registered futures: 0
[01:57:39.441] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.441] | : . ' , ; ` | : Total time: 0
[01:57:39.441] | : . ' , ; ` | Polling for a free worker ... done
[01:57:39.442] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.442] | : . ' , ; ` | : Listing all futures
[01:57:39.442] | : . ' , ; ` | : Number of registered futures: 0
[01:57:39.442] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.442] | : . ' , ; ` | avail: [n=2] '1', '2'
[01:57:39.443] | : . ' , ; ` | Index of first available worker: 1
[01:57:39.443] | : . ' , ; ` | Validate that the worker is functional ...
[01:57:39.574] | : . ' , ; ` | : Worker is functional
[01:57:39.575] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.575] | : . ' , ; ` | : . Listing all futures
[01:57:39.575] | : . ' , ; ` | : . Number of registered futures: 0
[01:57:39.576] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.576] | : . ' , ; ` | Validate that the worker is functional ... done
[01:57:39.576] | : . ' , ; ` requestNode() ... done
[01:57:39.576] | : . ' , ; ` cluster node index: 1
[01:57:39.576] | : . ' , ; requestWorker() ... done
[01:57:39.577] | : . ' , ; eraseGlobalEnvironment() ...
[01:57:39.577] | : . ' , ; eraseGlobalEnvironment() ... done
[01:57:39.578] | : . ' , ; launchFuture() ...
[01:57:39.578] | : . ' , ; ` cluster node index: 1
[01:57:39.578] | : . ' , ; ` getFutureData() ...
[01:57:39.578] | : . ' , ; ` | getFutureCore() ...
[01:57:39.579] | : . ' , ; ` | : Packages needed by the future expression (n = 0): <none>
[01:57:39.579] | : . ' , ; ` | getFutureCore() ... done
[01:57:39.579] | : . ' , ; ` | getFutureCapture() ...
[01:57:39.579] | : . ' , ; ` | getFutureCapture() ... done
[01:57:39.580] | : . ' , ; ` | getFutureContext() ...
[01:57:39.580] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.580] | : . ' , ; ` | : . Getting stack without first backend: [n=0] 
[01:57:39.580] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.581] | : . ' , ; ` | : Packages needed by future backend (n = 0): <none>
[01:57:39.581] | : . ' , ; ` | getFutureContext() ... done
[01:57:39.581] | : . ' , ; ` getFutureData() ... done
[01:57:39.582] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ...
[01:57:39.582] | : . ' , ; ` | Appended future to position #1
[01:57:39.582] | : . ' , ; ` | Number of registered futures: 1
[01:57:39.583] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ... done
[01:57:39.583] | : . ' , ; launchFuture() ... done
[01:57:39.583] | : . ' , ; MultisessionFuture started
[01:57:39.583] | : . ' , launchFuture() for ClusterFutureBackend ... done
[01:57:39.583] | : . ' Launching futures ... done
[01:57:39.584] | : . ' Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:57:39.584] | : . Using MultisessionFutureBackend ... done
[01:57:39.584] | : run() for 'Future' (NULL) ... done
[01:57:39.584] | future(..., label = NULL) ... done

> b %<-% {
+     "a"
+ }
[01:57:39.585] | future(..., label = NULL) ...
[01:57:39.585] | : lazy: FALSE
[01:57:39.585] | : stdout: TRUE
[01:57:39.585] | : conditions: [n=1] 'condition'
[01:57:39.586] | : gc: FALSE
[01:57:39.586] | : earlySignal: FALSE
Warning in getGlobalsAndPackages(expr, envir = envir, tweak = tweakExpression,  :
  R option 'future.globals.resolve' may only be used for troubleshooting. It must not be used in production since it changes how futures are evaluated and there is a great risk that the results cannot be reproduced elsewhere: 'TRUE'
[01:57:39.586] | : getGlobalsAndPackages() ...
[01:57:39.586] | : . Searching for globals ...
[01:57:39.591] | : . ' globals found: [1] '{'
[01:57:39.591] | : . Searching for globals ... done
[01:57:39.592] | : . Resolving globals: TRUE
[01:57:39.592] | : . Resolving any globals that are futures ...
[01:57:39.592] | : . ' globals: [1] '{'
[01:57:39.592] | : . Resolving any globals that are futures ... done
[01:57:39.593] | : . Search for packages associated with the globals ...
[01:57:39.593] | : . ' Packages associated with globals: [1] 'base'
[01:57:39.593] | : . ' Packages: [1] 'base'
[01:57:39.594] | : . Search for packages associated with the globals ... done
[01:57:39.594] | : . Packages after dropping 'base': [0] 
[01:57:39.594] | : . globals: [0] 
[01:57:39.594] | : . packages: [0] 
[01:57:39.595] | : getGlobalsAndPackages() ... done
[01:57:39.595] | : run() for 'Future' (NULL) ...
[01:57:39.595] | : . state: 'created'
[01:57:39.596] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.596] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.596] | : . Using MultisessionFutureBackend ...
[01:57:39.596] | : . ' Number of futures since start: 1 (1 created, 1 launched, 0 finished)
[01:57:39.596] | : . ' Launching futures ...
[01:57:39.597] | : . ' , launchFuture() for ClusterFutureBackend ...
[01:57:39.597] | : . ' , ; Workers: [n=2]
[01:57:39.597] | : . ' , ; Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-05-08 r88190 ucrt), platform x86_64-w64-mingw32)
[01:57:39.600] | : . ' , ; FutureRegistry: 'workers-ae95f3500835a0ac9cf9c52acb33ee0e'
[01:57:39.600] | : . ' , ; requestWorker() ...
[01:57:39.600] | : . ' , ; ` requestNode() ...
[01:57:39.600] | : . ' , ; ` | Number of workers: 2
[01:57:39.600] | : . ' , ; ` | Polling for a free worker ...
[01:57:39.601] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.601] | : . ' , ; ` | : . Listing all futures
[01:57:39.601] | : . ' , ; ` | : . Number of registered futures: 1
[01:57:39.601] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.601] | : . ' , ; ` | : Total time: 0
[01:57:39.602] | : . ' , ; ` | Polling for a free worker ... done
[01:57:39.602] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.602] | : . ' , ; ` | : Listing all futures
[01:57:39.602] | : . ' , ; ` | : Number of registered futures: 1
[01:57:39.602] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.603] | : . ' , ; ` | avail: [n=2] '2'
[01:57:39.603] | : . ' , ; ` | Index of first available worker: 2
[01:57:39.603] | : . ' , ; ` | Validate that the worker is functional ...
[01:57:39.731] | : . ' , ; ` | : Worker is functional
[01:57:39.732] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.732] | : . ' , ; ` | : . Listing all futures
[01:57:39.732] | : . ' , ; ` | : . Number of registered futures: 1
[01:57:39.732] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.732] | : . ' , ; ` | Validate that the worker is functional ... done
[01:57:39.733] | : . ' , ; ` requestNode() ... done
[01:57:39.733] | : . ' , ; ` cluster node index: 2
[01:57:39.733] | : . ' , ; requestWorker() ... done
[01:57:39.734] | : . ' , ; eraseGlobalEnvironment() ...
[01:57:39.735] | : . ' , ; eraseGlobalEnvironment() ... done
[01:57:39.735] | : . ' , ; launchFuture() ...
[01:57:39.735] | : . ' , ; ` cluster node index: 2
[01:57:39.736] | : . ' , ; ` getFutureData() ...
[01:57:39.736] | : . ' , ; ` | getFutureCore() ...
[01:57:39.736] | : . ' , ; ` | : Packages needed by the future expression (n = 0): <none>
[01:57:39.736] | : . ' , ; ` | getFutureCore() ... done
[01:57:39.737] | : . ' , ; ` | getFutureCapture() ...
[01:57:39.737] | : . ' , ; ` | getFutureCapture() ... done
[01:57:39.737] | : . ' , ; ` | getFutureContext() ...
[01:57:39.737] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.738] | : . ' , ; ` | : . Getting stack without first backend: [n=0] 
[01:57:39.738] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.738] | : . ' , ; ` | : Packages needed by future backend (n = 0): <none>
[01:57:39.738] | : . ' , ; ` | getFutureContext() ... done
[01:57:39.739] | : . ' , ; ` getFutureData() ... done
[01:57:39.739] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ...
[01:57:39.743] | : . ' , ; ` | Appended future to position #2
[01:57:39.743] | : . ' , ; ` | Number of registered futures: 2
[01:57:39.744] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ... done
[01:57:39.744] | : . ' , ; launchFuture() ... done
[01:57:39.744] | : . ' , ; MultisessionFuture started
[01:57:39.744] | : . ' , launchFuture() for ClusterFutureBackend ... done
[01:57:39.744] | : . ' Launching futures ... done
[01:57:39.745] | : . ' Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:57:39.745] | : . Using MultisessionFutureBackend ... done
[01:57:39.745] | : run() for 'Future' (NULL) ... done
[01:57:39.745] | future(..., label = NULL) ... done

> message(sprintf("b = %s\n", sQuote(b)))
[01:57:39.746] | value() for MultisessionFuture (NULL) ...
[01:57:39.747] | : result() for ClusterFuture ...
[01:57:39.747] | : . assertValidConnection() ...
[01:57:39.747] | : . ' cluster node index: 2
[01:57:39.748] | : . assertValidConnection() ... done
[01:57:39.749] | : . receiveMessageFromWorker() for ClusterFuture ...
[01:57:39.749] | : . ' cluster node index: 2
[01:57:39.799] | : . ' [1] TRUE
[01:57:39.799] | : . ' received data:
[01:57:39.800] | : . ' List of 5
[01:57:39.800] | : . '  $ type   : chr "VALUE"
[01:57:39.800] | : . '  $ value  :List of 14
[01:57:39.800] | : . '   ..$ value            : chr "a"
[01:57:39.800] | : . '   ..$ visible          : logi TRUE
[01:57:39.800] | : . '   ..$ stdout           : chr ""
[01:57:39.800] | : . '   ..$ conditions       : list()
[01:57:39.800] | : . '   ..$ rng              : logi FALSE
[01:57:39.800] | : . '   ..$ misuseGlobalEnv  : NULL
[01:57:39.800] | : . '   ..$ misuseConnections:List of 3
[01:57:39.800] | : . '   .. ..$ added   : NULL
[01:57:39.800] | : . '   .. ..$ removed : NULL
[01:57:39.800] | : . '   .. ..$ replaced: NULL
[01:57:39.800] | : . '   ..$ misuseDevices    : NULL
[01:57:39.800] | : . '   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.800] | : . '   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.800] | : . '   ..$ uuid             : chr [1:2] "80ba89934857e61dec4b0baeef799ef7" "2"
[01:57:39.800] | : . '   ..$ session_uuid     : chr "c963d51bb25e04c2ad0e9a62bcdf6bd5"
[01:57:39.800] | : . '   .. ..- attr(*, "source")=List of 5
[01:57:39.800] | : . '   .. .. ..$ host  : Named chr "CRANWIN3"
[01:57:39.800] | : . '   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:57:39.800] | : . '   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:57:39.800] | : . '   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:57:39.800] | : . '   .. .. ..$ pid   : int 133468
[01:57:39.800] | : . '   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.800] | : . '   .. .. ..$ random: int 2147483647
[01:57:39.800] | : . '   ..$ r_info           :List of 4
[01:57:39.800] | : . '   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:57:39.800] | : . '   .. .. ..$ : int [1:3] 4 6 0
[01:57:39.800] | : . '   .. ..$ os           : chr "windows"
[01:57:39.800] | : . '   .. ..$ os_name      : chr "Windows"
[01:57:39.800] | : . '   .. ..$ captures_utf8: logi TRUE
[01:57:39.800] | : . '   ..$ version          : chr "1.8"
[01:57:39.800] | : . '   ..- attr(*, "class")= chr "FutureResult"
[01:57:39.800] | : . '  $ success: logi TRUE
[01:57:39.800] | : . '  $ time   : 'proc_time' Named num [1:5] 0.06 0 0.06 NA NA
[01:57:39.800] | : . '   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:57:39.800] | : . '  $ tag    : NULL
[01:57:39.817] | : . ' Received FutureResult
[01:57:39.818] | : . ' FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ...
[01:57:39.818] | : . ' , Removed future from position #2
[01:57:39.818] | : . ' , Number of registered futures: 1
[01:57:39.818] | : . ' FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ... done
[01:57:39.819] | : . ' Erased future from future backend
[01:57:39.819] | : . ' result() for ClusterFuture ...
[01:57:39.819] | : . ' , result already collected: FutureResult
[01:57:39.819] | : . ' result() for ClusterFuture ... done
[01:57:39.820] | : . receiveMessageFromWorker() for ClusterFuture ... done
[01:57:39.820] | : result() for ClusterFuture ... done
[01:57:39.820] | : result() for ClusterFuture ...
[01:57:39.820] | : . result already collected: FutureResult
[01:57:39.820] | : result() for ClusterFuture ... done
[01:57:39.821] | : relay stdout ...
[01:57:39.821] | : relay stdout ... done
[01:57:39.821] | : check for misuse ...
[01:57:39.821] | : check for misuse ... done
[01:57:39.821] | value() for MultisessionFuture (NULL) ... done
b = 'a'


> y %<-% {
+     env[[b]]
+ }
[01:57:39.822] | future(..., label = NULL) ...
[01:57:39.822] | : lazy: FALSE
[01:57:39.822] | : stdout: TRUE
[01:57:39.822] | : conditions: [n=1] 'condition'
[01:57:39.823] | : gc: FALSE
[01:57:39.823] | : earlySignal: FALSE
Warning in getGlobalsAndPackages(expr, envir = envir, tweak = tweakExpression,  :
  R option 'future.globals.resolve' may only be used for troubleshooting. It must not be used in production since it changes how futures are evaluated and there is a great risk that the results cannot be reproduced elsewhere: 'TRUE'
[01:57:39.823] | : getGlobalsAndPackages() ...
[01:57:39.823] | : . Searching for globals ...
[01:57:39.831] | : . ' globals found: [4] '{', '[[', 'env', 'b'
[01:57:39.831] | : . Searching for globals ... done
[01:57:39.831] | : . Resolving globals: TRUE
[01:57:39.831] | : . Resolving any globals that are futures ...
[01:57:39.831] | : . ' globals: [4] '{', '[[', 'env', 'b'
[01:57:39.832] | : . Resolving any globals that are futures ... done
[01:57:39.832] | : . Search for packages associated with the globals ...
[01:57:39.832] | : . ' Packages associated with globals: [1] 'base'
[01:57:39.832] | : . ' Packages: [1] 'base'
[01:57:39.833] | : . Search for packages associated with the globals ... done
[01:57:39.833] | : . Resolving futures part of globals (recursively) ...
[01:57:39.833] | : . ' resolve() for FutureGlobals ...
[01:57:39.833] | : . ' , recursive: 99
[01:57:39.834] | : . ' , Number of elements: 2
[01:57:39.834] | : . ' , elements: 'env', 'b'
[01:57:39.835] | : . ' , 'obj' is environment
[01:57:39.835] | : . ' , resolve(obj, ...) ...
[01:57:39.835] | : . ' , ; resolve() for environment ...
[01:57:39.835] | : . ' , ; ` recursive: 98
[01:57:39.836] | : . ' , ; ` Number of elements: 2
[01:57:39.836] | : . ' , ; ` elements: [1] '.future_a', 'a'
[01:57:39.837] | : . ' , ; ` resolved() for MultisessionFuture (NULL) ...
[01:57:39.837] | : . ' , ; ` | Cluster node socket connection: index=4, id=279
[01:57:39.837] | : . ' , ; ` | assertValidConnection() ...
[01:57:39.838] | : . ' , ; ` | : cluster node index: 1
[01:57:39.838] | : . ' , ; ` | assertValidConnection() ... done
[01:57:39.838] | : . ' , ; ` | receiveMessageFromWorker() for ClusterFuture ...
[01:57:39.838] | : . ' , ; ` | : cluster node index: 1
[01:57:39.839] | : . ' , ; ` | : [1] TRUE
[01:57:39.839] | : . ' , ; ` | : received data:
[01:57:39.839] | : . ' , ; ` | : List of 5
[01:57:39.839] | : . ' , ; ` | :  $ type   : chr "VALUE"
[01:57:39.839] | : . ' , ; ` | :  $ value  :List of 14
[01:57:39.839] | : . ' , ; ` | :   ..$ value            : num 5
[01:57:39.839] | : . ' , ; ` | :   ..$ visible          : logi TRUE
[01:57:39.839] | : . ' , ; ` | :   ..$ stdout           : chr ""
[01:57:39.839] | : . ' , ; ` | :   ..$ conditions       : list()
[01:57:39.839] | : . ' , ; ` | :   ..$ rng              : logi FALSE
[01:57:39.839] | : . ' , ; ` | :   ..$ misuseGlobalEnv  : NULL
[01:57:39.839] | : . ' , ; ` | :   ..$ misuseConnections:List of 3
[01:57:39.839] | : . ' , ; ` | :   .. ..$ added   : NULL
[01:57:39.839] | : . ' , ; ` | :   .. ..$ removed : NULL
[01:57:39.839] | : . ' , ; ` | :   .. ..$ replaced: NULL
[01:57:39.839] | : . ' , ; ` | :   ..$ misuseDevices    : NULL
[01:57:39.839] | : . ' , ; ` | :   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.839] | : . ' , ; ` | :   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.839] | : . ' , ; ` | :   ..$ uuid             : chr [1:2] "80ba89934857e61dec4b0baeef799ef7" "1"
[01:57:39.839] | : . ' , ; ` | :   ..$ session_uuid     : chr "1580c7ad65bfe0f2207958b2cbf31fbb"
[01:57:39.839] | : . ' , ; ` | :   .. ..- attr(*, "source")=List of 5
[01:57:39.839] | : . ' , ; ` | :   .. .. ..$ host  : Named chr "CRANWIN3"
[01:57:39.839] | : . ' , ; ` | :   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:57:39.839] | : . ' , ; ` | :   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:57:39.839] | : . ' , ; ` | :   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:57:39.839] | : . ' , ; ` | :   .. .. ..$ pid   : int 31184
[01:57:39.839] | : . ' , ; ` | :   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.839] | : . ' , ; ` | :   .. .. ..$ random: int 2147483647
[01:57:39.839] | : . ' , ; ` | :   ..$ r_info           :List of 4
[01:57:39.839] | : . ' , ; ` | :   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:57:39.839] | : . ' , ; ` | :   .. .. ..$ : int [1:3] 4 6 0
[01:57:39.839] | : . ' , ; ` | :   .. ..$ os           : chr "windows"
[01:57:39.839] | : . ' , ; ` | :   .. ..$ os_name      : chr "Windows"
[01:57:39.839] | : . ' , ; ` | :   .. ..$ captures_utf8: logi TRUE
[01:57:39.839] | : . ' , ; ` | :   ..$ version          : chr "1.8"
[01:57:39.839] | : . ' , ; ` | :   ..- attr(*, "class")= chr "FutureResult"
[01:57:39.839] | : . ' , ; ` | :  $ success: logi TRUE
[01:57:39.839] | : . ' , ; ` | :  $ time   : 'proc_time' Named num [1:5] 0.07 0 0.06 NA NA
[01:57:39.839] | : . ' , ; ` | :   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:57:39.839] | : . ' , ; ` | :  $ tag    : NULL
[01:57:39.853] | : . ' , ; ` | : Received FutureResult
[01:57:39.853] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ...
[01:57:39.853] | : . ' , ; ` | : . Removed future from position #1
[01:57:39.853] | : . ' , ; ` | : . Number of registered futures: 0
[01:57:39.854] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ... done
[01:57:39.854] | : . ' , ; ` | : Erased future from future backend
[01:57:39.854] | : . ' , ; ` | : result() for ClusterFuture ...
[01:57:39.854] | : . ' , ; ` | : . result already collected: FutureResult
[01:57:39.854] | : . ' , ; ` | : result() for ClusterFuture ... done
[01:57:39.855] | : . ' , ; ` | receiveMessageFromWorker() for ClusterFuture ... done
[01:57:39.855] | : . ' , ; ` | receiveMessageFromWorker() returned object of class FutureResult; resolved
[01:57:39.855] | : . ' , ; ` resolved() for MultisessionFuture (NULL) ... done
[01:57:39.855] | : . ' , ; ` assertFutureResult() ...
[01:57:39.855] | : . ' , ; ` | Future uuid: 80ba89934857e61dec4b0baeef799ef7[01:57:39.855] | : . ' , ; ` | Future uuid: 1
[01:57:39.855] | : . ' , ; ` | identical; success
[01:57:39.856] | : . ' , ; ` assertFutureResult() ... done
[01:57:39.856] | : . ' , ; ` Future #1
[01:57:39.856] | : . ' , ; ` value() for MultisessionFuture (NULL) ...
[01:57:39.856] | : . ' , ; ` | result() for ClusterFuture ...
[01:57:39.856] | : . ' , ; ` | : result already collected: FutureResult
[01:57:39.857] | : . ' , ; ` | result() for ClusterFuture ... done
[01:57:39.857] | : . ' , ; ` | result() for ClusterFuture ...
[01:57:39.857] | : . ' , ; ` | : result already collected: FutureResult
[01:57:39.857] | : . ' , ; ` | result() for ClusterFuture ... done
[01:57:39.857] | : . ' , ; ` | check for misuse ...
[01:57:39.857] | : . ' , ; ` | check for misuse ... done
[01:57:39.858] | : . ' , ; ` value() for MultisessionFuture (NULL) ... done
[01:57:39.858] | : . ' , ; ` resolve() for MultisessionFuture ...
[01:57:39.858] | : . ' , ; ` | A MultisessionFuture was resolved
[01:57:39.858] | : . ' , ; ` resolve() for MultisessionFuture ... done
[01:57:39.859] | : . ' , ; ` length: 0 (resolved future 1)
[01:57:39.859] | : . ' , ; resolve() for environment ... done
[01:57:39.859] | : . ' , resolve(obj, ...) ... done
[01:57:39.859] | : . ' , resolved() for environment ...
[01:57:39.860] | : . ' , ; resolved() for list ...
[01:57:39.860] | : . ' , ; ` Number of elements: 1
[01:57:39.860] | : . ' , ; ` Number of futures: 1
[01:57:39.860] | : . ' , ; resolved() for list ... done
[01:57:39.860] | : . ' , resolved() for environment ... done
[01:57:39.861] | : . ' , length: 1 (resolved future 1)
[01:57:39.861] | : . ' , 'obj' is atomic
[01:57:39.861] | : . ' , length: 0 (resolved future 2)
[01:57:39.861] | : . ' resolve() for FutureGlobals ... done
[01:57:39.861] | : . ' globals: [2] 'env', 'b'
[01:57:39.862] | : . Resolving futures part of globals (recursively) ... done
[01:57:39.862] | : . Packages after dropping 'base': [0] 
[01:57:39.862] | : . globals: [2] 'env', 'b'
[01:57:39.862] | : . packages: [0] 
[01:57:39.862] | : getGlobalsAndPackages() ... done
[01:57:39.863] | : run() for 'Future' (NULL) ...
[01:57:39.863] | : . state: 'created'
[01:57:39.863] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.863] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.863] | : . Using MultisessionFutureBackend ...
[01:57:39.863] | : . ' Number of futures since start: 2 (2 created, 2 launched, 2 finished)
[01:57:39.864] | : . ' Launching futures ...
[01:57:39.864] | : . ' , launchFuture() for ClusterFutureBackend ...
[01:57:39.864] | : . ' , ; Workers: [n=2]
[01:57:39.864] | : . ' , ; Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-05-08 r88190 ucrt), platform x86_64-w64-mingw32)
[01:57:39.866] | : . ' , ; FutureRegistry: 'workers-ae95f3500835a0ac9cf9c52acb33ee0e'
[01:57:39.866] | : . ' , ; requestWorker() ...
[01:57:39.867] | : . ' , ; ` requestNode() ...
[01:57:39.867] | : . ' , ; ` | Number of workers: 2
[01:57:39.867] | : . ' , ; ` | Polling for a free worker ...
[01:57:39.867] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.867] | : . ' , ; ` | : . Listing all futures
[01:57:39.868] | : . ' , ; ` | : . Number of registered futures: 0
[01:57:39.868] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.868] | : . ' , ; ` | : Total time: 0
[01:57:39.868] | : . ' , ; ` | Polling for a free worker ... done
[01:57:39.868] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.868] | : . ' , ; ` | : Listing all futures
[01:57:39.869] | : . ' , ; ` | : Number of registered futures: 0
[01:57:39.869] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.869] | : . ' , ; ` | avail: [n=2] '1', '2'
[01:57:39.869] | : . ' , ; ` | Index of first available worker: 1
[01:57:39.869] | : . ' , ; ` | Validate that the worker is functional ...
[01:57:39.917] | : . ' , ; ` | : Worker is functional
[01:57:39.918] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.918] | : . ' , ; ` | : . Listing all futures
[01:57:39.918] | : . ' , ; ` | : . Number of registered futures: 0
[01:57:39.918] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.918] | : . ' , ; ` | Validate that the worker is functional ... done
[01:57:39.918] | : . ' , ; ` requestNode() ... done
[01:57:39.919] | : . ' , ; ` cluster node index: 1
[01:57:39.919] | : . ' , ; requestWorker() ... done
[01:57:39.919] | : . ' , ; eraseGlobalEnvironment() ...
[01:57:39.920] | : . ' , ; eraseGlobalEnvironment() ... done
[01:57:39.920] | : . ' , ; launchFuture() ...
[01:57:39.920] | : . ' , ; ` cluster node index: 1
[01:57:39.920] | : . ' , ; ` getFutureData() ...
[01:57:39.920] | : . ' , ; ` | getFutureCore() ...
[01:57:39.920] | : . ' , ; ` | : Packages needed by the future expression (n = 0): <none>
[01:57:39.921] | : . ' , ; ` | getFutureCore() ... done
[01:57:39.921] | : . ' , ; ` | getFutureCapture() ...
[01:57:39.921] | : . ' , ; ` | getFutureCapture() ... done
[01:57:39.921] | : . ' , ; ` | getFutureContext() ...
[01:57:39.921] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.921] | : . ' , ; ` | : . Getting stack without first backend: [n=0] 
[01:57:39.922] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.922] | : . ' , ; ` | : Packages needed by future backend (n = 0): <none>
[01:57:39.922] | : . ' , ; ` | getFutureContext() ... done
[01:57:39.922] | : . ' , ; ` getFutureData() ... done
[01:57:39.937] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ...
[01:57:39.938] | : . ' , ; ` | Appended future to position #1
[01:57:39.938] | : . ' , ; ` | Number of registered futures: 1
[01:57:39.939] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ... done
[01:57:39.939] | : . ' , ; launchFuture() ... done
[01:57:39.939] | : . ' , ; MultisessionFuture started
[01:57:39.939] | : . ' , launchFuture() for ClusterFutureBackend ... done
[01:57:39.940] | : . ' Launching futures ... done
[01:57:39.940] | : . ' Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:57:39.940] | : . Using MultisessionFutureBackend ... done
[01:57:39.940] | : run() for 'Future' (NULL) ... done
[01:57:39.940] | future(..., label = NULL) ... done

> message(sprintf("y = %s\n", y))
[01:57:39.941] | value() for MultisessionFuture (NULL) ...
[01:57:39.941] | : result() for ClusterFuture ...
[01:57:39.942] | : . assertValidConnection() ...
[01:57:39.942] | : . ' cluster node index: 1
[01:57:39.943] | : . assertValidConnection() ... done
[01:57:39.943] | : . receiveMessageFromWorker() for ClusterFuture ...
[01:57:39.943] | : . ' cluster node index: 1
[01:57:39.945] | : . ' [1] TRUE
[01:57:39.945] | : . ' received data:
[01:57:39.946] | : . ' List of 5
[01:57:39.946] | : . '  $ type   : chr "VALUE"
[01:57:39.946] | : . '  $ value  :List of 14
[01:57:39.946] | : . '   ..$ value            : num 5
[01:57:39.946] | : . '   ..$ visible          : logi TRUE
[01:57:39.946] | : . '   ..$ stdout           : chr ""
[01:57:39.946] | : . '   ..$ conditions       : list()
[01:57:39.946] | : . '   ..$ rng              : logi FALSE
[01:57:39.946] | : . '   ..$ misuseGlobalEnv  : NULL
[01:57:39.946] | : . '   ..$ misuseConnections:List of 3
[01:57:39.946] | : . '   .. ..$ added   : NULL
[01:57:39.946] | : . '   .. ..$ removed : NULL
[01:57:39.946] | : . '   .. ..$ replaced: NULL
[01:57:39.946] | : . '   ..$ misuseDevices    : NULL
[01:57:39.946] | : . '   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.946] | : . '   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.946] | : . '   ..$ uuid             : chr [1:2] "80ba89934857e61dec4b0baeef799ef7" "3"
[01:57:39.946] | : . '   ..$ session_uuid     : chr "1580c7ad65bfe0f2207958b2cbf31fbb"
[01:57:39.946] | : . '   .. ..- attr(*, "source")=List of 5
[01:57:39.946] | : . '   .. .. ..$ host  : Named chr "CRANWIN3"
[01:57:39.946] | : . '   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:57:39.946] | : . '   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:57:39.946] | : . '   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:57:39.946] | : . '   .. .. ..$ pid   : int 31184
[01:57:39.946] | : . '   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:39.946] | : . '   .. .. ..$ random: int 2147483647
[01:57:39.946] | : . '   ..$ r_info           :List of 4
[01:57:39.946] | : . '   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:57:39.946] | : . '   .. .. ..$ : int [1:3] 4 6 0
[01:57:39.946] | : . '   .. ..$ os           : chr "windows"
[01:57:39.946] | : . '   .. ..$ os_name      : chr "Windows"
[01:57:39.946] | : . '   .. ..$ captures_utf8: logi TRUE
[01:57:39.946] | : . '   ..$ version          : chr "1.8"
[01:57:39.946] | : . '   ..- attr(*, "class")= chr "FutureResult"
[01:57:39.946] | : . '  $ success: logi TRUE
[01:57:39.946] | : . '  $ time   : 'proc_time' Named num [1:5] 0 0 0 NA NA
[01:57:39.946] | : . '   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:57:39.946] | : . '  $ tag    : NULL
[01:57:39.961] | : . ' Received FutureResult
[01:57:39.962] | : . ' FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ...
[01:57:39.962] | : . ' , Removed future from position #1
[01:57:39.962] | : . ' , Number of registered futures: 0
[01:57:39.962] | : . ' FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ... done
[01:57:39.962] | : . ' Erased future from future backend
[01:57:39.963] | : . ' result() for ClusterFuture ...
[01:57:39.963] | : . ' , result already collected: FutureResult
[01:57:39.963] | : . ' result() for ClusterFuture ... done
[01:57:39.963] | : . receiveMessageFromWorker() for ClusterFuture ... done
[01:57:39.963] | : result() for ClusterFuture ... done
[01:57:39.964] | : result() for ClusterFuture ...
[01:57:39.964] | : . result already collected: FutureResult
[01:57:39.964] | : result() for ClusterFuture ... done
[01:57:39.964] | : relay stdout ...
[01:57:39.964] | : relay stdout ... done
[01:57:39.964] | : check for misuse ...
[01:57:39.965] | : check for misuse ... done
[01:57:39.965] | value() for MultisessionFuture (NULL) ... done
y = 5


> str(as.list(env))
[01:57:39.965] | value() for MultisessionFuture (NULL) ...
[01:57:39.965] | : result() for ClusterFuture ...
[01:57:39.966] | : . result already collected: FutureResult
[01:57:39.966] | : result() for ClusterFuture ... done
[01:57:39.966] | : result() for ClusterFuture ...
[01:57:39.966] | : . result already collected: FutureResult
[01:57:39.966] | : result() for ClusterFuture ... done
[01:57:39.967] | : relay stdout ...
[01:57:39.967] | : relay stdout ... done
[01:57:39.967] | : check for misuse ...
[01:57:39.967] | : check for misuse ... done
[01:57:39.967] | value() for MultisessionFuture (NULL) ... done
List of 1
 $ a: num 5

> y %<-% {
+     env[[b]]
+ }
[01:57:39.969] | future(..., label = NULL) ...
[01:57:39.969] | : lazy: FALSE
[01:57:39.969] | : stdout: TRUE
[01:57:39.969] | : conditions: [n=1] 'condition'
[01:57:39.969] | : gc: FALSE
[01:57:39.969] | : earlySignal: FALSE
Warning in getGlobalsAndPackages(expr, envir = envir, tweak = tweakExpression,  :
  R option 'future.globals.resolve' may only be used for troubleshooting. It must not be used in production since it changes how futures are evaluated and there is a great risk that the results cannot be reproduced elsewhere: 'TRUE'
[01:57:39.970] | : getGlobalsAndPackages() ...
[01:57:39.970] | : . Searching for globals ...
[01:57:39.977] | : . ' globals found: [4] '{', '[[', 'env', 'b'
[01:57:39.977] | : . Searching for globals ... done
[01:57:39.977] | : . Resolving globals: TRUE
[01:57:39.978] | : . Resolving any globals that are futures ...
[01:57:39.978] | : . ' globals: [4] '{', '[[', 'env', 'b'
[01:57:39.978] | : . Resolving any globals that are futures ... done
[01:57:39.978] | : . Search for packages associated with the globals ...
[01:57:39.978] | : . ' Packages associated with globals: [1] 'base'
[01:57:39.979] | : . ' Packages: [1] 'base'
[01:57:39.979] | : . Search for packages associated with the globals ... done
[01:57:39.979] | : . Resolving futures part of globals (recursively) ...
[01:57:39.979] | : . ' resolve() for FutureGlobals ...
[01:57:39.979] | : . ' , recursive: 99
[01:57:39.980] | : . ' , Number of elements: 2
[01:57:39.980] | : . ' , elements: 'env', 'b'
[01:57:39.980] | : . ' , 'obj' is environment
[01:57:39.980] | : . ' , resolve(obj, ...) ...
[01:57:39.980] | : . ' , ; resolve() for environment ...
[01:57:39.981] | : . ' , ; ` recursive: 98
[01:57:39.981] | : . ' , ; ` Number of elements: 1
[01:57:39.981] | : . ' , ; ` elements: [1] 'a'
[01:57:39.982] | : . ' , ; ` length: 0 (resolved future 1)
[01:57:39.982] | : . ' , ; resolve() for environment ... done
[01:57:39.982] | : . ' , resolve(obj, ...) ... done
[01:57:39.982] | : . ' , resolved() for environment ...
[01:57:39.982] | : . ' , ; resolved() for list ...
[01:57:39.983] | : . ' , ; ` Number of elements: 1
[01:57:39.983] | : . ' , ; ` Number of futures: 1
[01:57:39.983] | : . ' , ; resolved() for list ... done
[01:57:39.983] | : . ' , resolved() for environment ... done
[01:57:39.983] | : . ' , length: 1 (resolved future 1)
[01:57:39.983] | : . ' , 'obj' is atomic
[01:57:39.984] | : . ' , length: 0 (resolved future 2)
[01:57:39.984] | : . ' resolve() for FutureGlobals ... done
[01:57:39.984] | : . ' globals: [2] 'env', 'b'
[01:57:39.984] | : . Resolving futures part of globals (recursively) ... done
[01:57:39.984] | : . Packages after dropping 'base': [0] 
[01:57:39.985] | : . globals: [2] 'env', 'b'
[01:57:39.985] | : . packages: [0] 
[01:57:39.985] | : getGlobalsAndPackages() ... done
[01:57:39.985] | : run() for 'Future' (NULL) ...
[01:57:39.985] | : . state: 'created'
[01:57:39.986] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:39.986] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:39.986] | : . Using MultisessionFutureBackend ...
[01:57:39.986] | : . ' Number of futures since start: 3 (3 created, 3 launched, 3 finished)
[01:57:39.986] | : . ' Launching futures ...
[01:57:39.987] | : . ' , launchFuture() for ClusterFutureBackend ...
[01:57:39.987] | : . ' , ; Workers: [n=2]
[01:57:39.987] | : . ' , ; Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-05-08 r88190 ucrt), platform x86_64-w64-mingw32)
[01:57:39.989] | : . ' , ; FutureRegistry: 'workers-ae95f3500835a0ac9cf9c52acb33ee0e'
[01:57:39.989] | : . ' , ; requestWorker() ...
[01:57:39.989] | : . ' , ; ` requestNode() ...
[01:57:39.989] | : . ' , ; ` | Number of workers: 2
[01:57:39.990] | : . ' , ; ` | Polling for a free worker ...
[01:57:39.990] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.990] | : . ' , ; ` | : . Listing all futures
[01:57:39.990] | : . ' , ; ` | : . Number of registered futures: 0
[01:57:39.990] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.990] | : . ' , ; ` | : Total time: 0
[01:57:39.991] | : . ' , ; ` | Polling for a free worker ... done
[01:57:39.991] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:39.991] | : . ' , ; ` | : Listing all futures
[01:57:39.991] | : . ' , ; ` | : Number of registered futures: 0
[01:57:39.991] | : . ' , ; ` | FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:39.991] | : . ' , ; ` | avail: [n=2] '1', '2'
[01:57:39.992] | : . ' , ; ` | Index of first available worker: 1
[01:57:39.992] | : . ' , ; ` | Validate that the worker is functional ...
[01:57:40.039] | : . ' , ; ` | : Worker is functional
[01:57:40.039] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ...
[01:57:40.039] | : . ' , ; ` | : . Listing all futures
[01:57:40.040] | : . ' , ; ` | : . Number of registered futures: 0
[01:57:40.040] | : . ' , ; ` | : FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'list', earlySignal = 0) ... done
[01:57:40.040] | : . ' , ; ` | Validate that the worker is functional ... done
[01:57:40.040] | : . ' , ; ` requestNode() ... done
[01:57:40.040] | : . ' , ; ` cluster node index: 1
[01:57:40.041] | : . ' , ; requestWorker() ... done
[01:57:40.041] | : . ' , ; eraseGlobalEnvironment() ...
[01:57:40.041] | : . ' , ; eraseGlobalEnvironment() ... done
[01:57:40.041] | : . ' , ; launchFuture() ...
[01:57:40.042] | : . ' , ; ` cluster node index: 1
[01:57:40.042] | : . ' , ; ` getFutureData() ...
[01:57:40.042] | : . ' , ; ` | getFutureCore() ...
[01:57:40.042] | : . ' , ; ` | : Packages needed by the future expression (n = 0): <none>
[01:57:40.042] | : . ' , ; ` | getFutureCore() ... done
[01:57:40.042] | : . ' , ; ` | getFutureCapture() ...
[01:57:40.043] | : . ' , ; ` | getFutureCapture() ... done
[01:57:40.043] | : . ' , ; ` | getFutureContext() ...
[01:57:40.043] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:57:40.043] | : . ' , ; ` | : . Getting stack without first backend: [n=0] 
[01:57:40.043] | : . ' , ; ` | : plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:57:40.044] | : . ' , ; ` | : Packages needed by future backend (n = 0): <none>
[01:57:40.044] | : . ' , ; ` | getFutureContext() ... done
[01:57:40.044] | : . ' , ; ` getFutureData() ... done
[01:57:40.044] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ...
[01:57:40.045] | : . ' , ; ` | Appended future to position #1
[01:57:40.045] | : . ' , ; ` | Number of registered futures: 1
[01:57:40.045] | : . ' , ; ` FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'add', earlySignal = 0) ... done
[01:57:40.045] | : . ' , ; launchFuture() ... done
[01:57:40.045] | : . ' , ; MultisessionFuture started
[01:57:40.046] | : . ' , launchFuture() for ClusterFutureBackend ... done
[01:57:40.046] | : . ' Launching futures ... done
[01:57:40.046] | : . ' Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:57:40.046] | : . Using MultisessionFutureBackend ... done
[01:57:40.046] | : run() for 'Future' (NULL) ... done
[01:57:40.046] | future(..., label = NULL) ... done

> message(sprintf("y = %s\n", y))
[01:57:40.047] | value() for MultisessionFuture (NULL) ...
[01:57:40.047] | : result() for ClusterFuture ...
[01:57:40.047] | : . assertValidConnection() ...
[01:57:40.047] | : . ' cluster node index: 1
[01:57:40.048] | : . assertValidConnection() ... done
[01:57:40.048] | : . receiveMessageFromWorker() for ClusterFuture ...
[01:57:40.048] | : . ' cluster node index: 1
[01:57:40.049] | : . ' [1] TRUE
[01:57:40.049] | : . ' received data:
[01:57:40.050] | : . ' List of 5
[01:57:40.050] | : . '  $ type   : chr "VALUE"
[01:57:40.050] | : . '  $ value  :List of 14
[01:57:40.050] | : . '   ..$ value            : num 5
[01:57:40.050] | : . '   ..$ visible          : logi TRUE
[01:57:40.050] | : . '   ..$ stdout           : chr ""
[01:57:40.050] | : . '   ..$ conditions       : list()
[01:57:40.050] | : . '   ..$ rng              : logi FALSE
[01:57:40.050] | : . '   ..$ misuseGlobalEnv  : NULL
[01:57:40.050] | : . '   ..$ misuseConnections:List of 3
[01:57:40.050] | : . '   .. ..$ added   : NULL
[01:57:40.050] | : . '   .. ..$ removed : NULL
[01:57:40.050] | : . '   .. ..$ replaced: NULL
[01:57:40.050] | : . '   ..$ misuseDevices    : NULL
[01:57:40.050] | : . '   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:57:40"
[01:57:40.050] | : . '   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:57:40"
[01:57:40.050] | : . '   ..$ uuid             : chr [1:2] "80ba89934857e61dec4b0baeef799ef7" "4"
[01:57:40.050] | : . '   ..$ session_uuid     : chr "1580c7ad65bfe0f2207958b2cbf31fbb"
[01:57:40.050] | : . '   .. ..- attr(*, "source")=List of 5
[01:57:40.050] | : . '   .. .. ..$ host  : Named chr "CRANWIN3"
[01:57:40.050] | : . '   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:57:40.050] | : . '   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:57:40.050] | : . '   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:57:40.050] | : . '   .. .. ..$ pid   : int 31184
[01:57:40.050] | : . '   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:57:39"
[01:57:40.050] | : . '   .. .. ..$ random: int 2147483647
[01:57:40.050] | : . '   ..$ r_info           :List of 4
[01:57:40.050] | : . '   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:57:40.050] | : . '   .. .. ..$ : int [1:3] 4 6 0
[01:57:40.050] | : . '   .. ..$ os           : chr "windows"
[01:57:40.050] | : . '   .. ..$ os_name      : chr "Windows"
[01:57:40.050] | : . '   .. ..$ captures_utf8: logi TRUE
[01:57:40.050] | : . '   ..$ version          : chr "1.8"
[01:57:40.050] | : . '   ..- attr(*, "class")= chr "FutureResult"
[01:57:40.050] | : . '  $ success: logi TRUE
[01:57:40.050] | : . '  $ time   : 'proc_time' Named num [1:5] 0.01 0 0.01 NA NA
[01:57:40.050] | : . '   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:57:40.050] | : . '  $ tag    : NULL
[01:57:40.063] | : . ' Received FutureResult
[01:57:40.063] | : . ' FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ...
[01:57:40.063] | : . ' , Removed future from position #1
[01:57:40.063] | : . ' , Number of registered futures: 0
[01:57:40.064] | : . ' FutureRegistry('workers-ae95f3500835a0ac9cf9c52acb33ee0e', action = 'remove', earlySignal = 0) ... done
[01:57:40.064] | : . ' Erased future from future backend
[01:57:40.064] | : . ' result() for ClusterFuture ...
[01:57:40.064] | : . ' , result already collected: FutureResult
[01:57:40.064] | : . ' result() for ClusterFuture ... done
[01:57:40.065] | : . receiveMessageFromWorker() for ClusterFuture ... done
[01:57:40.065] | : result() for ClusterFuture ... done
[01:57:40.065] | : result() for ClusterFuture ...
[01:57:40.065] | : . result already collected: FutureResult
[01:57:40.065] | : result() for ClusterFuture ... done
[01:57:40.066] | : relay stdout ...
[01:57:40.066] | : relay stdout ... done
[01:57:40.066] | : check for misuse ...
[01:57:40.066] | : check for misuse ... done
[01:57:40.066] | value() for MultisessionFuture (NULL) ... done
y = 5


> message("*** Tricky use cases related to globals (part 2) ... DONE")
*** Tricky use cases related to globals (part 2) ... DONE

> setTimeLimit()
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_05_09_01_55_17_23336'
Sourcing 6 epilogue scripts ... done
Test time: user.self=0.6s, sys.self=0.03s, elapsed=1s, user.child=NAs, sys.child=NAs
Test 'globals,resolve' ... success
> 
> proc.time()
   user  system elapsed 
   0.76    0.12    1.56