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-demo-mandelbrot.R
> ## Don't edit - it was autogenerated by inst/testme/deploy.R
> future:::testme("demo-mandelbrot")
Test 'demo-mandelbrot' ...
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-demo-mandelbrot.R'

> library(future)
[01:56:52.583] Option 'future.startup.script': TRUE
[01:56:52.584] Future startup scripts considered: '.future.R', '~/.future.R'
[01:56:52.584] Future startup scripts found: <none>

> if (getRversion() < "4.1") options(future.debug = FALSE)

> message("*** Mandelbrot demo of the 'future' package ...")
*** Mandelbrot demo of the 'future' package ...

> options(future.demo.mandelbrot.nrow = 2)

> options(future.demo.mandelbrot.resolution = 50)

> options(future.demo.mandelbrot.delay = FALSE)

> for (cores in 1:availCores) {
+     message(sprintf("Testing with %d cores ...", cores))
+     options(mc.cores = cores)
+     for (strategy in supp .... [TRUNCATED] 
Testing with 1 cores ...
- plan('sequential') ...
[01:56:52.593] plan(<name>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:52.594] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ...
[01:56:52.594] | : all.equal() for FutureStrategyList ...
[01:56:52.594] | : . New stack:
[01:56:52.594] | : . List of 1
[01:56:52.594] | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.594] | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.594] | : .   ..- attr(*, "init")= logi TRUE
[01:56:52.594] | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.594] | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.594] | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.594] | : .   ..- attr(*, "call")= language plan(strategy)
[01:56:52.594] | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.600] | : . Old stack:
[01:56:52.600] | : . List of 1
[01:56:52.600] | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.600] | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.600] | : .   ..- attr(*, "init")= logi TRUE
[01:56:52.600] | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.600] | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.600] | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.600] | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:52.600] | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.606] | : . Not identical
[01:56:52.606] | : . all.equal() for future ...
[01:56:52.606] | : . ' List of 2
[01:56:52.606] | : . '  $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.606] | : . '   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.606] | : . '   ..- attr(*, "init")= logi TRUE
[01:56:52.606] | : . '   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.606] | : . '   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.606] | : . '   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.606] | : . '   ..- attr(*, "call")= language plan(strategy)
[01:56:52.606] | : . '  $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.606] | : . '   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.606] | : . '   ..- attr(*, "init")= logi TRUE
[01:56:52.606] | : . '   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.606] | : . '   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.606] | : . '   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.606] | : . '   ..- attr(*, "call")= language plan(sequential)
[01:56:52.612] | : . all.equal() for future ... done
[01:56:52.613] | : all.equal() for FutureStrategyList ... done
[01:56:52.613] | : plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:52.613] | : List of future strategies:
[01:56:52.613] | : 1. sequential:
[01:56:52.613] | :    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:52.613] | :    - tweaked: FALSE
[01:56:52.613] | :    - call: plan(sequential)
[01:56:52.614] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done
[01:56:52.614] plan(<name>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done


	demo(mandelbrot)
	---- ~~~~~~~~~~

> library(future)

> library(graphics)

> plot_what_is_done <- function(counts) {
+   for (kk in seq_along(counts)) {
+     f <- counts[[kk]]
+ 
+     ## Already plotted?
+     if (!inherits(f, "Future")) next
+ 
+     ## Not resolved?
+     if (!resolved(f)) next
+ 
+     message(sprintf("Plotting tile #%d of %d ...", kk, n))
+     counts[[kk]] <- value(f)
+     screen(kk)
+     plot(counts[[kk]])
+   }
+ 
+   counts
+ }

> ## Options
> region <- getOption("future.demo.mandelbrot.region", 1L)

> if (!is.list(region)) {
+   if (region == 1L) {
+     region <- list(xmid = -0.75, ymid = 0.0, side = 3.0)
+   } else if (region == 2L) {
+     region <- list(xmid = 0.283, ymid = -0.0095, side = 0.00026)
+   } else if (region == 3L) {
+     region <- list(xmid = 0.282989, ymid = -0.01, side = 3e-8)
+   }
+ }

> nrow <- getOption("future.demo.mandelbrot.nrow", 3L)

> resolution <- getOption("future.demo.mandelbrot.resolution", 400L)

> delay <- getOption("future.demo.mandelbrot.delay", interactive())

> if (isTRUE(delay)) {
+   delay <- function(counts) Sys.sleep(1.0)
+ } else if (!is.function(delay)) {
+   delay <- function(counts) {}
+ }

> ## Generate Mandelbrot tiles to be computed
> Cs <- mandelbrot_tiles(xmid = region$xmid, ymid = region$ymid,
+                        side = region$side, nrow = nrow,
+                        resolution = resolution)

> if (interactive()) {
+   dev.new()
+   plot.new()
+   split.screen(dim(Cs))
+   for (ii in seq_along(Cs)) {
+     screen(ii)
+     par(mar = c(0, 0, 0, 0))
+     text(x = 1 / 2, y = 1 / 2, sprintf("Future #%d\nunresolved", ii), cex = 2)
+   }
+ } else {
+   split.screen(dim(Cs))
+ }
[1] 1 2 3 4

> ## Create all Mandelbrot tiles via lazy futures
> n <- length(Cs)

> message(sprintf("Creating %d Mandelbrot tiles:", n), appendLF = FALSE)
Creating 4 Mandelbrot tiles:
> counts <- lapply(seq_along(Cs), FUN=function(ii) {
+   message(" ", ii, appendLF = FALSE)
+   C <- Cs[[ii]]
+   future({
+     message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE)
+     fit <- mandelbrot(C)
+ 
+     ## Emulate slowness
+     delay(fit)
+ 
+     message(" done")
+     fit
+   }, lazy = TRUE)
+ })
 1[01:56:52.667] future(..., label = NULL) ...
[01:56:52.667] | lazy: TRUE
[01:56:52.667] | stdout: TRUE
[01:56:52.668] | conditions: [n=1] 'condition'
[01:56:52.668] | gc: FALSE
[01:56:52.668] | earlySignal: FALSE
[01:56:52.669] | getGlobalsAndPackages() ...
[01:56:52.669] | : Searching for globals ...
[01:56:52.737] | : . globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:52.737] | : Searching for globals ... done
[01:56:52.737] | : Resolving globals: FALSE
[01:56:52.737] | : Search for packages associated with the globals ...
[01:56:52.738] | : . Packages associated with globals: [2] 'base', 'future'
[01:56:52.738] | : . Packages: [2] 'base', 'future'
[01:56:52.739] | : Search for packages associated with the globals ... done
[01:56:52.739] | : Packages after dropping 'base': [1] 'future'
[01:56:52.739] | : Packages after dropping non-attached packages: [1] 'future'
[01:56:52.739] | : globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:52.740] | : packages: [1] 'future'
[01:56:52.740] | getGlobalsAndPackages() ... done
[01:56:52.740] future(..., label = NULL) ... done
 2[01:56:52.746] future(..., label = NULL) ...
[01:56:52.746] | lazy: TRUE
[01:56:52.746] | stdout: TRUE
[01:56:52.746] | conditions: [n=1] 'condition'
[01:56:52.746] | gc: FALSE
[01:56:52.747] | earlySignal: FALSE
[01:56:52.747] | getGlobalsAndPackages() ...
[01:56:52.747] | : Searching for globals ...
[01:56:52.802] | : . globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:52.802] | : Searching for globals ... done
[01:56:52.802] | : Resolving globals: FALSE
[01:56:52.802] | : Search for packages associated with the globals ...
[01:56:52.803] | : . Packages associated with globals: [2] 'base', 'future'
[01:56:52.803] | : . Packages: [2] 'base', 'future'
[01:56:52.804] | : Search for packages associated with the globals ... done
[01:56:52.804] | : Packages after dropping 'base': [1] 'future'
[01:56:52.804] | : Packages after dropping non-attached packages: [1] 'future'
[01:56:52.804] | : globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:52.805] | : packages: [1] 'future'
[01:56:52.805] | getGlobalsAndPackages() ... done
[01:56:52.805] future(..., label = NULL) ... done
 3[01:56:52.805] future(..., label = NULL) ...
[01:56:52.806] | lazy: TRUE
[01:56:52.806] | stdout: TRUE
[01:56:52.806] | conditions: [n=1] 'condition'
[01:56:52.806] | gc: FALSE
[01:56:52.806] | earlySignal: FALSE
[01:56:52.807] | getGlobalsAndPackages() ...
[01:56:52.807] | : Searching for globals ...
[01:56:52.843] | : . globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:52.843] | : Searching for globals ... done
[01:56:52.844] | : Resolving globals: FALSE
[01:56:52.844] | : Search for packages associated with the globals ...
[01:56:52.844] | : . Packages associated with globals: [2] 'base', 'future'
[01:56:52.845] | : . Packages: [2] 'base', 'future'
[01:56:52.845] | : Search for packages associated with the globals ... done
[01:56:52.845] | : Packages after dropping 'base': [1] 'future'
[01:56:52.846] | : Packages after dropping non-attached packages: [1] 'future'
[01:56:52.846] | : globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:52.846] | : packages: [1] 'future'
[01:56:52.846] | getGlobalsAndPackages() ... done
[01:56:52.847] future(..., label = NULL) ... done
 4[01:56:52.847] future(..., label = NULL) ...
[01:56:52.847] | lazy: TRUE
[01:56:52.847] | stdout: TRUE
[01:56:52.847] | conditions: [n=1] 'condition'
[01:56:52.848] | gc: FALSE
[01:56:52.848] | earlySignal: FALSE
[01:56:52.848] | getGlobalsAndPackages() ...
[01:56:52.848] | : Searching for globals ...
[01:56:52.881] | : . globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:52.881] | : Searching for globals ... done
[01:56:52.881] | : Resolving globals: FALSE
[01:56:52.882] | : Search for packages associated with the globals ...
[01:56:52.882] | : . Packages associated with globals: [2] 'base', 'future'
[01:56:52.883] | : . Packages: [2] 'base', 'future'
[01:56:52.883] | : Search for packages associated with the globals ... done
[01:56:52.883] | : Packages after dropping 'base': [1] 'future'
[01:56:52.883] | : Packages after dropping non-attached packages: [1] 'future'
[01:56:52.883] | : globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:52.884] | : packages: [1] 'future'
[01:56:52.884] | getGlobalsAndPackages() ... done
[01:56:52.884] future(..., label = NULL) ... done

> message(".")
.

> ## Calculate and plot tiles
> repeat {
+   counts <- plot_what_is_done(counts)
+   if (!any(sapply(counts, FUN = inherits, "Future"))) break
+ }
[01:56:52.895] resolved() for Future (NULL) ...
[01:56:52.895] | state: 'created'
[01:56:52.895] | run: TRUE
[01:56:52.896] | run() ...
[01:56:52.896] | : run() for 'Future' (NULL) ...
[01:56:52.896] | : . state: 'created'
[01:56:52.896] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:52.897] | : . ' plan(): plan_init() of 'sequential', 'uniprocess', 'future', 'function' ...
[01:56:52.897] | : . ' , function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.897] | : . ' ,  - attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.897] | : . ' ,  - attr(*, "init")= logi TRUE
[01:56:52.897] | : . ' ,  - attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.897] | : . ' ,   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.897] | : . ' ,  - attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.897] | : . ' ,  - attr(*, "call")= language plan(sequential)
[01:56:52.899] | : . ' , init: TRUE
[01:56:52.900] | : . ' , makeFutureBackend(<sequential>) ...
[01:56:52.900] | : . ' , ; Backend function: <'NULL'>
[01:56:52.900] | : . ' , ; Evaluator tweak arguments: [n=0]
[01:56:52.900] | : . ' , ;  list()
[01:56:52.901] | : . ' , ; Evaluator formal arguments: [n=2]
[01:56:52.901] | : . ' , ;  list()
[01:56:52.901] | : . ' , ; Backend factory arguments: [n=2]
[01:56:52.901] | : . ' , ; Dotted pair list of 2
[01:56:52.901] | : . ' , ;  $ gc         : logi FALSE
[01:56:52.901] | : . ' , ;  $ earlySignal: logi FALSE
[01:56:52.903] | : . ' , ; Backend: <'SequentialFutureBackend', 'FutureBackend', 'environment'>
[01:56:52.903] | : . ' , makeFutureBackend(<sequential>) ... done
[01:56:52.903] | : . ' plan(): plan_init() of 'sequential', 'uniprocess', 'future', 'function' ... done
[01:56:52.903] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:52.903] | : . Using SequentialFutureBackend ...
[01:56:52.904] | : . ' Number of futures since start: 0 (0 created, 0 launched, 0 finished)
[01:56:52.904] | : . ' Launching futures ...
[01:56:52.904] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ...
[01:56:52.905] | : . ' , ; getFutureData() ...
[01:56:52.905] | : . ' , ; ` getFutureCore() ...
[01:56:52.905] | : . ' , ; ` | Packages needed by the future expression (n = 1): 'future'
[01:56:52.905] | : . ' , ; ` getFutureCore() ... done
[01:56:52.905] | : . ' , ; ` getFutureCapture() ...
[01:56:52.905] | : . ' , ; ` getFutureCapture() ... done
[01:56:52.906] | : . ' , ; ` getFutureContext() ...
[01:56:52.906] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:52.906] | : . ' , ; ` | : Getting stack without first backend: [n=0] 
[01:56:52.906] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:52.907] | : . ' , ; ` | Packages needed by future backend (n = 0): <none>
[01:56:52.907] | : . ' , ; ` getFutureContext() ... done
[01:56:52.907] | : . ' , ; getFutureData() ... done
[01:56:52.908] | : . ' , ; attachPackages() ...
[01:56:52.909] | : . ' , ; ` packages: [n=1] 'future'
[01:56:52.909] | : . ' , ; attachPackages() ... done
[01:56:52.909] | : . ' , ; attachPackages() ...
[01:56:52.909] | : . ' , ; ` packages: [n=1] 'future'
[01:56:52.909] | : . ' , ; attachPackages() ... done
[01:56:52.910] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:52.910] | : . ' , ; ` Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function'
[01:56:52.910] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:52.911] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:52.911] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:52.911] | : . ' , ; ` | all.equal() for FutureStrategyList ...
[01:56:52.912] | : . ' , ; ` | : New stack:
[01:56:52.912] | : . ' , ; ` | : List of 1
[01:56:52.912] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.912] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.912] | : . ' , ; ` | :   ..- attr(*, "init")= logi TRUE
[01:56:52.912] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.912] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.912] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.912] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:52.912] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.915] | : . ' , ; ` | : Old stack:
[01:56:52.915] | : . ' , ; ` | : List of 1
[01:56:52.915] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.915] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.915] | : . ' , ; ` | :   ..- attr(*, "init")= chr "done"
[01:56:52.915] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.915] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.915] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.915] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(sequential)
[01:56:52.915] | : . ' , ; ` | :   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:52.915] | : . ' , ; ` | :   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.915] | : . ' , ; ` | :   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.915] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.919] | : . ' , ; ` | : Not identical
[01:56:52.919] | : . ' , ; ` | : all.equal() for future ...
[01:56:52.920] | : . ' , ; ` | : . List of 2
[01:56:52.920] | : . ' , ; ` | : .  $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "init")= logi TRUE
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.920] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:52.920] | : . ' , ; ` | : .  $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.920] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:52.920] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:52.920] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.920] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.926] | : . ' , ; ` | : all.equal() for future ... done
[01:56:52.926] | : . ' , ; ` | all.equal() for FutureStrategyList ... done
[01:56:52.927] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:52.927] | : . ' , ; ` | List of future strategies:
[01:56:52.927] | : . ' , ; ` | 1. sequential:
[01:56:52.927] | : . ' , ; ` |    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:52.927] | : . ' , ; ` |    - tweaked: FALSE
[01:56:52.927] | : . ' , ; ` |    - call: plan(sequential)
[01:56:52.927] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:52.928] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:52.928] | : . ' , ; assign_globals() ...
[01:56:52.928] | : . ' , ; List of 4
[01:56:52.928] | : . ' , ;  $ ii   : int 1
[01:56:52.928] | : . ' , ;  $ n    : int 4
[01:56:52.928] | : . ' , ;  $ C    : cplx [1:25, 1:25] -2.25-1.5i -2.25-1.44i -2.25-1.38i ...
[01:56:52.928] | : . ' , ;   ..- attr(*, "region")=List of 2
[01:56:52.928] | : . ' , ;   .. ..$ xrange: num [1:2] -2.25 -0.781
[01:56:52.928] | : . ' , ;   .. ..$ yrange: num [1:2] -1.5 -0.0306
[01:56:52.928] | : . ' , ;   ..- attr(*, "tile")= int [1:2] 1 1
[01:56:52.928] | : . ' , ;  $ delay:function (counts)  
[01:56:52.928] | : . ' , ;   ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41
[01:56:52.928] | : . ' , ;   .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c063064bf8> 
[01:56:52.928] | : . ' , ;  - attr(*, "where")=List of 4
[01:56:52.928] | : . ' , ;   ..$ ii   :<environment: 0x000002c06367eb50> 
[01:56:52.928] | : . ' , ;   ..$ n    :<environment: R_GlobalEnv> 
[01:56:52.928] | : . ' , ;   ..$ C    :<environment: 0x000002c06367eb50> 
[01:56:52.928] | : . ' , ;   ..$ delay:<environment: R_GlobalEnv> 
[01:56:52.928] | : . ' , ;  - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list"
[01:56:52.928] | : . ' , ;  - attr(*, "resolved")= logi FALSE
[01:56:52.928] | : . ' , ;  - attr(*, "total_size")= num NA
[01:56:52.928] | : . ' , ;  - attr(*, "already-done")= logi TRUE
[01:56:52.939] | : . ' , ; - copied 'ii' to environment
[01:56:52.939] | : . ' , ; - copied 'n' to environment
[01:56:52.939] | : . ' , ; - copied 'C' to environment
[01:56:52.940] | : . ' , ; - reassign environment for 'delay' [where=globalenv()]
[01:56:52.940] | : . ' , ; - copied 'delay' to environment
[01:56:52.940] | : . ' , ; assign_globals() ... done
[01:56:52.946] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:52.946] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:52.946] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:52.946] | : . ' , ; ` | : all.equal() for FutureStrategyList ...
[01:56:52.947] | : . ' , ; ` | : . New stack:
[01:56:52.947] | : . ' , ; ` | : . List of 1
[01:56:52.947] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.947] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.947] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:52.947] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.947] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.947] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.947] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:52.947] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:52.947] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.947] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.947] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.951] | : . ' , ; ` | : . Old stack:
[01:56:52.951] | : . ' , ; ` | : . List of 1
[01:56:52.951] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.951] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.951] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:52.951] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.951] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.951] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.951] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:52.951] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:52.951] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.951] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.951] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.956] | : . ' , ; ` | : . Identical
[01:56:52.956] | : . ' , ; ` | : all.equal() for FutureStrategyList ... done
[01:56:52.956] | : . ' , ; ` | : plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:52.956] | : . ' , ; ` | : List of future strategies:
[01:56:52.956] | : . ' , ; ` | : 1. sequential:
[01:56:52.956] | : . ' , ; ` | :    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:52.956] | : . ' , ; ` | :    - tweaked: FALSE
[01:56:52.956] | : . ' , ; ` | :    - call: plan(sequential)
[01:56:52.957] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:52.957] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:52.957] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:52.964] | : . ' , ; SequentialFuture started (and completed)
[01:56:52.964] | : . ' , ; signalConditions() ...
[01:56:52.965] | : . ' , ; ` include = 'immediateCondition'
[01:56:52.965] | : . ' , ; ` exclude = 
[01:56:52.965] | : . ' , ; ` resignal = FALSE
[01:56:52.965] | : . ' , ; ` Number of conditions: 2
[01:56:52.965] | : . ' , ; signalConditions() ... done
[01:56:52.966] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done
[01:56:52.966] | : . ' Launching futures ... done
[01:56:52.966] | : . ' Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future'
[01:56:52.966] | : . Using SequentialFutureBackend ... done
[01:56:52.966] | : run() for 'Future' (NULL) ... done
[01:56:52.967] | run() ... done
[01:56:52.967] | resolved() ...
[01:56:52.967] | : resolved() for SequentialFuture (NULL) ...
[01:56:52.967] | : . state: 'finished'
[01:56:52.967] | : . run: TRUE
[01:56:52.967] | : . result: 'FutureResult'
[01:56:52.968] | : resolved() for SequentialFuture (NULL) ... done
[01:56:52.968] | : resolved: TRUE
[01:56:52.968] | resolved() ... done
[01:56:52.968] resolved() for Future (NULL) ... done
Plotting tile #1 of 4 ...
[01:56:52.969] value() for SequentialFuture (NULL) ...
[01:56:52.969] | signalConditions() ...
[01:56:52.969] | : include = 'immediateCondition'
[01:56:52.969] | : exclude = 
[01:56:52.969] | : resignal = FALSE
[01:56:52.970] | : Number of conditions: 2
[01:56:52.970] | signalConditions() ... done
[01:56:52.970] | relay stdout ...
[01:56:52.970] | relay stdout ... done
[01:56:52.970] | check for misuse ...
[01:56:52.970] | check for misuse ... done
[01:56:52.971] | relay conditions ...
[01:56:52.971] | : Future state: 'finished'
[01:56:52.971] | : signalConditions() ...
[01:56:52.971] | : . include = 'condition'
[01:56:52.971] | : . exclude = 'immediateCondition'
[01:56:52.971] | : . resignal = TRUE
[01:56:52.972] | : . Number of conditions: 2
[01:56:52.972] | : . Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #1 of 4 ...[01:56:52.972] | : . Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:52.972] | : signalConditions() ... done
[01:56:52.972] | relay conditions ... done
[01:56:52.973] value() for SequentialFuture (NULL) ... done
[01:56:52.974] resolved() for Future (NULL) ...
[01:56:52.975] | state: 'created'
[01:56:52.975] | run: TRUE
[01:56:52.975] | run() ...
[01:56:52.975] | : run() for 'Future' (NULL) ...
[01:56:52.975] | : . state: 'created'
[01:56:52.975] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:52.976] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:52.976] | : . Using SequentialFutureBackend ...
[01:56:52.976] | : . ' Number of futures since start: 1 (1 created, 1 launched, 1 finished)
[01:56:52.976] | : . ' Launching futures ...
[01:56:52.976] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ...
[01:56:52.976] | : . ' , ; getFutureData() ...
[01:56:52.977] | : . ' , ; ` getFutureCore() ...
[01:56:52.977] | : . ' , ; ` | Packages needed by the future expression (n = 1): 'future'
[01:56:52.977] | : . ' , ; ` getFutureCore() ... done
[01:56:52.977] | : . ' , ; ` getFutureCapture() ...
[01:56:52.977] | : . ' , ; ` getFutureCapture() ... done
[01:56:52.978] | : . ' , ; ` getFutureContext() ...
[01:56:52.978] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:52.978] | : . ' , ; ` | : Getting stack without first backend: [n=0] 
[01:56:52.978] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:52.978] | : . ' , ; ` | Packages needed by future backend (n = 0): <none>
[01:56:52.978] | : . ' , ; ` getFutureContext() ... done
[01:56:52.979] | : . ' , ; getFutureData() ... done
[01:56:52.979] | : . ' , ; attachPackages() ...
[01:56:52.979] | : . ' , ; ` packages: [n=1] 'future'
[01:56:52.979] | : . ' , ; attachPackages() ... done
[01:56:52.980] | : . ' , ; attachPackages() ...
[01:56:52.980] | : . ' , ; ` packages: [n=1] 'future'
[01:56:52.980] | : . ' , ; attachPackages() ... done
[01:56:52.980] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:52.981] | : . ' , ; ` Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function'
[01:56:52.981] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:52.981] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:52.981] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:52.982] | : . ' , ; ` | all.equal() for FutureStrategyList ...
[01:56:52.982] | : . ' , ; ` | : New stack:
[01:56:52.982] | : . ' , ; ` | : List of 1
[01:56:52.982] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.982] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.982] | : . ' , ; ` | :   ..- attr(*, "init")= logi TRUE
[01:56:52.982] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.982] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.982] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.982] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:52.982] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.985] | : . ' , ; ` | : Old stack:
[01:56:52.985] | : . ' , ; ` | : List of 1
[01:56:52.985] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.985] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.985] | : . ' , ; ` | :   ..- attr(*, "init")= chr "done"
[01:56:52.985] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.985] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.985] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.985] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(sequential)
[01:56:52.985] | : . ' , ; ` | :   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:52.985] | : . ' , ; ` | :   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.985] | : . ' , ; ` | :   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.985] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:52.989] | : . ' , ; ` | : Not identical
[01:56:52.990] | : . ' , ; ` | : all.equal() for future ...
[01:56:52.990] | : . ' , ; ` | : . List of 2
[01:56:52.990] | : . ' , ; ` | : .  $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "init")= logi TRUE
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.990] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:52.990] | : . ' , ; ` | : .  $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.990] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:52.990] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:52.990] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:52.990] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:52.997] | : . ' , ; ` | : all.equal() for future ... done
[01:56:52.997] | : . ' , ; ` | all.equal() for FutureStrategyList ... done
[01:56:52.997] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:52.997] | : . ' , ; ` | List of future strategies:
[01:56:52.997] | : . ' , ; ` | 1. sequential:
[01:56:52.997] | : . ' , ; ` |    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:52.997] | : . ' , ; ` |    - tweaked: FALSE
[01:56:52.997] | : . ' , ; ` |    - call: plan(sequential)
[01:56:52.998] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:52.998] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:52.998] | : . ' , ; assign_globals() ...
[01:56:52.998] | : . ' , ; List of 4
[01:56:52.998] | : . ' , ;  $ ii   : int 2
[01:56:52.998] | : . ' , ;  $ n    : int 4
[01:56:52.998] | : . ' , ;  $ C    : cplx [1:25, 1:25] -0.719-1.5i -0.719-1.44i -0.719-1.38i ...
[01:56:52.998] | : . ' , ;   ..- attr(*, "region")=List of 2
[01:56:52.998] | : . ' , ;   .. ..$ xrange: num [1:2] -0.719 0.75
[01:56:52.998] | : . ' , ;   .. ..$ yrange: num [1:2] -1.5 -0.0306
[01:56:52.998] | : . ' , ;   ..- attr(*, "tile")= int [1:2] 1 2
[01:56:52.998] | : . ' , ;  $ delay:function (counts)  
[01:56:52.998] | : . ' , ;   ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41
[01:56:52.998] | : . ' , ;   .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c063064bf8> 
[01:56:52.998] | : . ' , ;  - attr(*, "where")=List of 4
[01:56:52.998] | : . ' , ;   ..$ ii   :<environment: 0x000002c061a556f0> 
[01:56:52.998] | : . ' , ;   ..$ n    :<environment: R_GlobalEnv> 
[01:56:52.998] | : . ' , ;   ..$ C    :<environment: 0x000002c061a556f0> 
[01:56:52.998] | : . ' , ;   ..$ delay:<environment: R_GlobalEnv> 
[01:56:52.998] | : . ' , ;  - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list"
[01:56:52.998] | : . ' , ;  - attr(*, "resolved")= logi FALSE
[01:56:52.998] | : . ' , ;  - attr(*, "total_size")= num NA
[01:56:52.998] | : . ' , ;  - attr(*, "already-done")= logi TRUE
[01:56:53.006] | : . ' , ; - copied 'ii' to environment
[01:56:53.006] | : . ' , ; - copied 'n' to environment
[01:56:53.006] | : . ' , ; - copied 'C' to environment
[01:56:53.007] | : . ' , ; - reassign environment for 'delay' [where=globalenv()]
[01:56:53.007] | : . ' , ; - copied 'delay' to environment
[01:56:53.007] | : . ' , ; assign_globals() ... done
[01:56:53.012] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.012] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.012] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:53.012] | : . ' , ; ` | : all.equal() for FutureStrategyList ...
[01:56:53.013] | : . ' , ; ` | : . New stack:
[01:56:53.013] | : . ' , ; ` | : . List of 1
[01:56:53.013] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.013] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.013] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.013] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.013] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.013] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.013] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.013] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.013] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.013] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.013] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.017] | : . ' , ; ` | : . Old stack:
[01:56:53.017] | : . ' , ; ` | : . List of 1
[01:56:53.017] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.017] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.017] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.017] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.017] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.017] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.017] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.017] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.017] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.017] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.017] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.021] | : . ' , ; ` | : . Identical
[01:56:53.021] | : . ' , ; ` | : all.equal() for FutureStrategyList ... done
[01:56:53.021] | : . ' , ; ` | : plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:53.021] | : . ' , ; ` | : List of future strategies:
[01:56:53.021] | : . ' , ; ` | : 1. sequential:
[01:56:53.021] | : . ' , ; ` | :    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:53.021] | : . ' , ; ` | :    - tweaked: FALSE
[01:56:53.021] | : . ' , ; ` | :    - call: plan(sequential)
[01:56:53.022] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:53.022] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.022] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.023] | : . ' , ; SequentialFuture started (and completed)
[01:56:53.023] | : . ' , ; signalConditions() ...
[01:56:53.023] | : . ' , ; ` include = 'immediateCondition'
[01:56:53.024] | : . ' , ; ` exclude = 
[01:56:53.024] | : . ' , ; ` resignal = FALSE
[01:56:53.024] | : . ' , ; ` Number of conditions: 2
[01:56:53.024] | : . ' , ; signalConditions() ... done
[01:56:53.024] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done
[01:56:53.024] | : . ' Launching futures ... done
[01:56:53.025] | : . ' Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future'
[01:56:53.025] | : . Using SequentialFutureBackend ... done
[01:56:53.025] | : run() for 'Future' (NULL) ... done
[01:56:53.025] | run() ... done
[01:56:53.025] | resolved() ...
[01:56:53.026] | : resolved() for SequentialFuture (NULL) ...
[01:56:53.026] | : . state: 'finished'
[01:56:53.026] | : . run: TRUE
[01:56:53.026] | : . result: 'FutureResult'
[01:56:53.026] | : resolved() for SequentialFuture (NULL) ... done
[01:56:53.026] | : resolved: TRUE
[01:56:53.026] | resolved() ... done
[01:56:53.027] resolved() for Future (NULL) ... done
Plotting tile #2 of 4 ...
[01:56:53.027] value() for SequentialFuture (NULL) ...
[01:56:53.027] | signalConditions() ...
[01:56:53.027] | : include = 'immediateCondition'
[01:56:53.027] | : exclude = 
[01:56:53.028] | : resignal = FALSE
[01:56:53.028] | : Number of conditions: 2
[01:56:53.028] | signalConditions() ... done
[01:56:53.028] | relay stdout ...
[01:56:53.028] | relay stdout ... done
[01:56:53.028] | check for misuse ...
[01:56:53.029] | check for misuse ... done
[01:56:53.029] | relay conditions ...
[01:56:53.029] | : Future state: 'finished'
[01:56:53.029] | : signalConditions() ...
[01:56:53.029] | : . include = 'condition'
[01:56:53.029] | : . exclude = 'immediateCondition'
[01:56:53.030] | : . resignal = TRUE
[01:56:53.030] | : . Number of conditions: 2
[01:56:53.030] | : . Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #2 of 4 ...[01:56:53.030] | : . Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:53.030] | : signalConditions() ... done
[01:56:53.030] | relay conditions ... done
[01:56:53.031] value() for SequentialFuture (NULL) ... done
[01:56:53.031] resolved() for Future (NULL) ...
[01:56:53.032] | state: 'created'
[01:56:53.032] | run: TRUE
[01:56:53.032] | run() ...
[01:56:53.032] | : run() for 'Future' (NULL) ...
[01:56:53.032] | : . state: 'created'
[01:56:53.032] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.033] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.033] | : . Using SequentialFutureBackend ...
[01:56:53.033] | : . ' Number of futures since start: 2 (2 created, 2 launched, 2 finished)
[01:56:53.033] | : . ' Launching futures ...
[01:56:53.033] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ...
[01:56:53.033] | : . ' , ; getFutureData() ...
[01:56:53.034] | : . ' , ; ` getFutureCore() ...
[01:56:53.034] | : . ' , ; ` | Packages needed by the future expression (n = 1): 'future'
[01:56:53.034] | : . ' , ; ` getFutureCore() ... done
[01:56:53.034] | : . ' , ; ` getFutureCapture() ...
[01:56:53.034] | : . ' , ; ` getFutureCapture() ... done
[01:56:53.035] | : . ' , ; ` getFutureContext() ...
[01:56:53.035] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.035] | : . ' , ; ` | : Getting stack without first backend: [n=0] 
[01:56:53.035] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.035] | : . ' , ; ` | Packages needed by future backend (n = 0): <none>
[01:56:53.035] | : . ' , ; ` getFutureContext() ... done
[01:56:53.036] | : . ' , ; getFutureData() ... done
[01:56:53.036] | : . ' , ; attachPackages() ...
[01:56:53.036] | : . ' , ; ` packages: [n=1] 'future'
[01:56:53.036] | : . ' , ; attachPackages() ... done
[01:56:53.036] | : . ' , ; attachPackages() ...
[01:56:53.037] | : . ' , ; ` packages: [n=1] 'future'
[01:56:53.037] | : . ' , ; attachPackages() ... done
[01:56:53.037] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.037] | : . ' , ; ` Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function'
[01:56:53.038] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.038] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.038] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:53.039] | : . ' , ; ` | all.equal() for FutureStrategyList ...
[01:56:53.039] | : . ' , ; ` | : New stack:
[01:56:53.039] | : . ' , ; ` | : List of 1
[01:56:53.039] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.039] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.039] | : . ' , ; ` | :   ..- attr(*, "init")= logi TRUE
[01:56:53.039] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.039] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.039] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.039] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:53.039] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.042] | : . ' , ; ` | : Old stack:
[01:56:53.042] | : . ' , ; ` | : List of 1
[01:56:53.042] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.042] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.042] | : . ' , ; ` | :   ..- attr(*, "init")= chr "done"
[01:56:53.042] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.042] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.042] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.042] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(sequential)
[01:56:53.042] | : . ' , ; ` | :   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.042] | : . ' , ; ` | :   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.042] | : . ' , ; ` | :   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.042] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.046] | : . ' , ; ` | : Not identical
[01:56:53.046] | : . ' , ; ` | : all.equal() for future ...
[01:56:53.047] | : . ' , ; ` | : . List of 2
[01:56:53.047] | : . ' , ; ` | : .  $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "init")= logi TRUE
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.047] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:53.047] | : . ' , ; ` | : .  $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.047] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.047] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.047] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.047] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.053] | : . ' , ; ` | : all.equal() for future ... done
[01:56:53.053] | : . ' , ; ` | all.equal() for FutureStrategyList ... done
[01:56:53.054] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:53.054] | : . ' , ; ` | List of future strategies:
[01:56:53.054] | : . ' , ; ` | 1. sequential:
[01:56:53.054] | : . ' , ; ` |    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:53.054] | : . ' , ; ` |    - tweaked: FALSE
[01:56:53.054] | : . ' , ; ` |    - call: plan(sequential)
[01:56:53.054] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:53.055] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.055] | : . ' , ; assign_globals() ...
[01:56:53.055] | : . ' , ; List of 4
[01:56:53.055] | : . ' , ;  $ ii   : int 3
[01:56:53.055] | : . ' , ;  $ n    : int 4
[01:56:53.055] | : . ' , ;  $ C    : cplx [1:25, 1:25] -2.25+0.0306i -2.25+0.0918i -2.25+0.1531i ...
[01:56:53.055] | : . ' , ;   ..- attr(*, "region")=List of 2
[01:56:53.055] | : . ' , ;   .. ..$ xrange: num [1:2] -2.25 -0.781
[01:56:53.055] | : . ' , ;   .. ..$ yrange: num [1:2] 0.0306 1.5
[01:56:53.055] | : . ' , ;   ..- attr(*, "tile")= int [1:2] 2 1
[01:56:53.055] | : . ' , ;  $ delay:function (counts)  
[01:56:53.055] | : . ' , ;   ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41
[01:56:53.055] | : . ' , ;   .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c063064bf8> 
[01:56:53.055] | : . ' , ;  - attr(*, "where")=List of 4
[01:56:53.055] | : . ' , ;   ..$ ii   :<environment: 0x000002c064b76cb8> 
[01:56:53.055] | : . ' , ;   ..$ n    :<environment: R_GlobalEnv> 
[01:56:53.055] | : . ' , ;   ..$ C    :<environment: 0x000002c064b76cb8> 
[01:56:53.055] | : . ' , ;   ..$ delay:<environment: R_GlobalEnv> 
[01:56:53.055] | : . ' , ;  - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list"
[01:56:53.055] | : . ' , ;  - attr(*, "resolved")= logi FALSE
[01:56:53.055] | : . ' , ;  - attr(*, "total_size")= num NA
[01:56:53.055] | : . ' , ;  - attr(*, "already-done")= logi TRUE
[01:56:53.065] | : . ' , ; - copied 'ii' to environment
[01:56:53.065] | : . ' , ; - copied 'n' to environment
[01:56:53.065] | : . ' , ; - copied 'C' to environment
[01:56:53.065] | : . ' , ; - reassign environment for 'delay' [where=globalenv()]
[01:56:53.066] | : . ' , ; - copied 'delay' to environment
[01:56:53.066] | : . ' , ; assign_globals() ... done
[01:56:53.069] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.069] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.070] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:53.070] | : . ' , ; ` | : all.equal() for FutureStrategyList ...
[01:56:53.070] | : . ' , ; ` | : . New stack:
[01:56:53.070] | : . ' , ; ` | : . List of 1
[01:56:53.070] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.070] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.070] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.070] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.070] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.070] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.070] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.070] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.070] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.070] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.070] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.074] | : . ' , ; ` | : . Old stack:
[01:56:53.074] | : . ' , ; ` | : . List of 1
[01:56:53.074] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.074] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.074] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.074] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.074] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.074] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.074] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.074] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.074] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.074] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.074] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.078] | : . ' , ; ` | : . Identical
[01:56:53.078] | : . ' , ; ` | : all.equal() for FutureStrategyList ... done
[01:56:53.079] | : . ' , ; ` | : plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:53.079] | : . ' , ; ` | : List of future strategies:
[01:56:53.079] | : . ' , ; ` | : 1. sequential:
[01:56:53.079] | : . ' , ; ` | :    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:53.079] | : . ' , ; ` | :    - tweaked: FALSE
[01:56:53.079] | : . ' , ; ` | :    - call: plan(sequential)
[01:56:53.079] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:53.080] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.080] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.080] | : . ' , ; SequentialFuture started (and completed)
[01:56:53.081] | : . ' , ; signalConditions() ...
[01:56:53.081] | : . ' , ; ` include = 'immediateCondition'
[01:56:53.081] | : . ' , ; ` exclude = 
[01:56:53.081] | : . ' , ; ` resignal = FALSE
[01:56:53.081] | : . ' , ; ` Number of conditions: 2
[01:56:53.081] | : . ' , ; signalConditions() ... done
[01:56:53.082] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done
[01:56:53.082] | : . ' Launching futures ... done
[01:56:53.082] | : . ' Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future'
[01:56:53.082] | : . Using SequentialFutureBackend ... done
[01:56:53.082] | : run() for 'Future' (NULL) ... done
[01:56:53.082] | run() ... done
[01:56:53.083] | resolved() ...
[01:56:53.083] | : resolved() for SequentialFuture (NULL) ...
[01:56:53.083] | : . state: 'finished'
[01:56:53.083] | : . run: TRUE
[01:56:53.083] | : . result: 'FutureResult'
[01:56:53.083] | : resolved() for SequentialFuture (NULL) ... done
[01:56:53.084] | : resolved: TRUE
[01:56:53.084] | resolved() ... done
[01:56:53.084] resolved() for Future (NULL) ... done
Plotting tile #3 of 4 ...
[01:56:53.084] value() for SequentialFuture (NULL) ...
[01:56:53.084] | signalConditions() ...
[01:56:53.085] | : include = 'immediateCondition'
[01:56:53.085] | : exclude = 
[01:56:53.085] | : resignal = FALSE
[01:56:53.085] | : Number of conditions: 2
[01:56:53.085] | signalConditions() ... done
[01:56:53.085] | relay stdout ...
[01:56:53.085] | relay stdout ... done
[01:56:53.086] | check for misuse ...
[01:56:53.086] | check for misuse ... done
[01:56:53.086] | relay conditions ...
[01:56:53.086] | : Future state: 'finished'
[01:56:53.086] | : signalConditions() ...
[01:56:53.086] | : . include = 'condition'
[01:56:53.087] | : . exclude = 'immediateCondition'
[01:56:53.087] | : . resignal = TRUE
[01:56:53.087] | : . Number of conditions: 2
[01:56:53.087] | : . Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #3 of 4 ...[01:56:53.087] | : . Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:53.088] | : signalConditions() ... done
[01:56:53.088] | relay conditions ... done
[01:56:53.088] value() for SequentialFuture (NULL) ... done
[01:56:53.089] resolved() for Future (NULL) ...
[01:56:53.089] | state: 'created'
[01:56:53.089] | run: TRUE
[01:56:53.089] | run() ...
[01:56:53.089] | : run() for 'Future' (NULL) ...
[01:56:53.090] | : . state: 'created'
[01:56:53.090] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.090] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.090] | : . Using SequentialFutureBackend ...
[01:56:53.090] | : . ' Number of futures since start: 3 (3 created, 3 launched, 3 finished)
[01:56:53.090] | : . ' Launching futures ...
[01:56:53.091] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ...
[01:56:53.091] | : . ' , ; getFutureData() ...
[01:56:53.091] | : . ' , ; ` getFutureCore() ...
[01:56:53.091] | : . ' , ; ` | Packages needed by the future expression (n = 1): 'future'
[01:56:53.091] | : . ' , ; ` getFutureCore() ... done
[01:56:53.091] | : . ' , ; ` getFutureCapture() ...
[01:56:53.092] | : . ' , ; ` getFutureCapture() ... done
[01:56:53.092] | : . ' , ; ` getFutureContext() ...
[01:56:53.092] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.092] | : . ' , ; ` | : Getting stack without first backend: [n=0] 
[01:56:53.092] | : . ' , ; ` | plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.092] | : . ' , ; ` | Packages needed by future backend (n = 0): <none>
[01:56:53.093] | : . ' , ; ` getFutureContext() ... done
[01:56:53.093] | : . ' , ; getFutureData() ... done
[01:56:53.093] | : . ' , ; attachPackages() ...
[01:56:53.093] | : . ' , ; ` packages: [n=1] 'future'
[01:56:53.094] | : . ' , ; attachPackages() ... done
[01:56:53.094] | : . ' , ; attachPackages() ...
[01:56:53.094] | : . ' , ; ` packages: [n=1] 'future'
[01:56:53.094] | : . ' , ; attachPackages() ... done
[01:56:53.095] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.095] | : . ' , ; ` Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function'
[01:56:53.095] | : . ' , ; plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.095] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.096] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:53.096] | : . ' , ; ` | all.equal() for FutureStrategyList ...
[01:56:53.096] | : . ' , ; ` | : New stack:
[01:56:53.096] | : . ' , ; ` | : List of 1
[01:56:53.096] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.096] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.096] | : . ' , ; ` | :   ..- attr(*, "init")= logi TRUE
[01:56:53.096] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.096] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.096] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.096] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:53.096] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.099] | : . ' , ; ` | : Old stack:
[01:56:53.100] | : . ' , ; ` | : List of 1
[01:56:53.100] | : . ' , ; ` | :  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.100] | : . ' , ; ` | :   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.100] | : . ' , ; ` | :   ..- attr(*, "init")= chr "done"
[01:56:53.100] | : . ' , ; ` | :   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.100] | : . ' , ; ` | :   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.100] | : . ' , ; ` | :   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.100] | : . ' , ; ` | :   ..- attr(*, "call")= language plan(sequential)
[01:56:53.100] | : . ' , ; ` | :   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.100] | : . ' , ; ` | :   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.100] | : . ' , ; ` | :   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.100] | : . ' , ; ` | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.104] | : . ' , ; ` | : Not identical
[01:56:53.104] | : . ' , ; ` | : all.equal() for future ...
[01:56:53.104] | : . ' , ; ` | : . List of 2
[01:56:53.104] | : . ' , ; ` | : .  $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "init")= logi TRUE
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.104] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE)
[01:56:53.104] | : . ' , ; ` | : .  $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.104] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.104] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.104] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.104] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.111] | : . ' , ; ` | : all.equal() for future ... done
[01:56:53.111] | : . ' , ; ` | all.equal() for FutureStrategyList ... done
[01:56:53.111] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:53.111] | : . ' , ; ` | List of future strategies:
[01:56:53.111] | : . ' , ; ` | 1. sequential:
[01:56:53.111] | : . ' , ; ` |    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:53.111] | : . ' , ; ` |    - tweaked: FALSE
[01:56:53.111] | : . ' , ; ` |    - call: plan(sequential)
[01:56:53.112] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:53.112] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.112] | : . ' , ; assign_globals() ...
[01:56:53.112] | : . ' , ; List of 4
[01:56:53.112] | : . ' , ;  $ ii   : int 4
[01:56:53.112] | : . ' , ;  $ n    : int 4
[01:56:53.112] | : . ' , ;  $ C    : cplx [1:25, 1:25] -0.719+0.0306i -0.719+0.0918i -0.719+0.1531i ...
[01:56:53.112] | : . ' , ;   ..- attr(*, "region")=List of 2
[01:56:53.112] | : . ' , ;   .. ..$ xrange: num [1:2] -0.719 0.75
[01:56:53.112] | : . ' , ;   .. ..$ yrange: num [1:2] 0.0306 1.5
[01:56:53.112] | : . ' , ;   ..- attr(*, "tile")= int [1:2] 2 2
[01:56:53.112] | : . ' , ;  $ delay:function (counts)  
[01:56:53.112] | : . ' , ;   ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41
[01:56:53.112] | : . ' , ;   .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c063064bf8> 
[01:56:53.112] | : . ' , ;  - attr(*, "where")=List of 4
[01:56:53.112] | : . ' , ;   ..$ ii   :<environment: 0x000002c0671186d8> 
[01:56:53.112] | : . ' , ;   ..$ n    :<environment: R_GlobalEnv> 
[01:56:53.112] | : . ' , ;   ..$ C    :<environment: 0x000002c0671186d8> 
[01:56:53.112] | : . ' , ;   ..$ delay:<environment: R_GlobalEnv> 
[01:56:53.112] | : . ' , ;  - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list"
[01:56:53.112] | : . ' , ;  - attr(*, "resolved")= logi FALSE
[01:56:53.112] | : . ' , ;  - attr(*, "total_size")= num NA
[01:56:53.112] | : . ' , ;  - attr(*, "already-done")= logi TRUE
[01:56:53.120] | : . ' , ; - copied 'ii' to environment
[01:56:53.120] | : . ' , ; - copied 'n' to environment
[01:56:53.121] | : . ' , ; - copied 'C' to environment
[01:56:53.121] | : . ' , ; - reassign environment for 'delay' [where=globalenv()]
[01:56:53.121] | : . ' , ; - copied 'delay' to environment
[01:56:53.121] | : . ' , ; assign_globals() ... done
[01:56:53.125] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.125] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ...
[01:56:53.126] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ...
[01:56:53.126] | : . ' , ; ` | : all.equal() for FutureStrategyList ...
[01:56:53.126] | : . ' , ; ` | : . New stack:
[01:56:53.126] | : . ' , ; ` | : . List of 1
[01:56:53.126] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.126] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.126] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.126] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.126] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.126] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.126] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.126] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.126] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.126] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.126] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.130] | : . ' , ; ` | : . Old stack:
[01:56:53.130] | : . ' , ; ` | : . List of 1
[01:56:53.130] | : . ' , ; ` | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.130] | : . ' , ; ` | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.130] | : . ' , ; ` | : .   ..- attr(*, "init")= chr "done"
[01:56:53.130] | : . ' , ; ` | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.130] | : . ' , ; ` | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.130] | : . ' , ; ` | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.130] | : . ' , ; ` | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.130] | : . ' , ; ` | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.130] | : . ' , ; ` | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.130] | : . ' , ; ` | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.130] | : . ' , ; ` | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.134] | : . ' , ; ` | : . Identical
[01:56:53.135] | : . ' , ; ` | : all.equal() for FutureStrategyList ... done
[01:56:53.135] | : . ' , ; ` | : plan(): Skip setting new future backend stack because it is the same as the current one:
[01:56:53.135] | : . ' , ; ` | : List of future strategies:
[01:56:53.135] | : . ' , ; ` | : 1. sequential:
[01:56:53.135] | : . ' , ; ` | :    - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "<NULL>")
[01:56:53.135] | : . ' , ; ` | :    - tweaked: FALSE
[01:56:53.135] | : . ' , ; ` | :    - call: plan(sequential)
[01:56:53.136] | : . ' , ; ` | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done
[01:56:53.136] | : . ' , ; ` plan(<FutureStrategyList>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.136] | : . ' , ; plan(<name>, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done
[01:56:53.136] | : . ' , ; SequentialFuture started (and completed)
[01:56:53.137] | : . ' , ; signalConditions() ...
[01:56:53.137] | : . ' , ; ` include = 'immediateCondition'
[01:56:53.137] | : . ' , ; ` exclude = 
[01:56:53.137] | : . ' , ; ` resignal = FALSE
[01:56:53.137] | : . ' , ; ` Number of conditions: 2
[01:56:53.138] | : . ' , ; signalConditions() ... done
[01:56:53.138] | : . ' , launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done
[01:56:53.138] | : . ' Launching futures ... done
[01:56:53.138] | : . ' Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future'
[01:56:53.138] | : . Using SequentialFutureBackend ... done
[01:56:53.138] | : run() for 'Future' (NULL) ... done
[01:56:53.139] | run() ... done
[01:56:53.139] | resolved() ...
[01:56:53.139] | : resolved() for SequentialFuture (NULL) ...
[01:56:53.139] | : . state: 'finished'
[01:56:53.139] | : . run: TRUE
[01:56:53.139] | : . result: 'FutureResult'
[01:56:53.140] | : resolved() for SequentialFuture (NULL) ... done
[01:56:53.140] | : resolved: TRUE
[01:56:53.140] | resolved() ... done
[01:56:53.140] resolved() for Future (NULL) ... done
Plotting tile #4 of 4 ...
[01:56:53.140] value() for SequentialFuture (NULL) ...
[01:56:53.140] | signalConditions() ...
[01:56:53.141] | : include = 'immediateCondition'
[01:56:53.141] | : exclude = 
[01:56:53.141] | : resignal = FALSE
[01:56:53.141] | : Number of conditions: 2
[01:56:53.141] | signalConditions() ... done
[01:56:53.141] | relay stdout ...
[01:56:53.142] | relay stdout ... done
[01:56:53.142] | check for misuse ...
[01:56:53.142] | check for misuse ... done
[01:56:53.142] | relay conditions ...
[01:56:53.142] | : Future state: 'finished'
[01:56:53.142] | : signalConditions() ...
[01:56:53.143] | : . include = 'condition'
[01:56:53.143] | : . exclude = 'immediateCondition'
[01:56:53.143] | : . resignal = TRUE
[01:56:53.143] | : . Number of conditions: 2
[01:56:53.143] | : . Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #4 of 4 ...[01:56:53.143] | : . Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:53.144] | : signalConditions() ... done
[01:56:53.144] | relay conditions ... done
[01:56:53.144] value() for SequentialFuture (NULL) ... done

> close.screen()
[1] 1 2 3 4

> message("SUGGESTION: Try to rerun this demo after changing strategy for how futures are resolved, e.g. plan(multisession).\n")
SUGGESTION: Try to rerun this demo after changing strategy for how futures are resolved, e.g. plan(multisession).

- plan('sequential') ... DONE
Testing with 1 cores ... DONE
Testing with 2 cores ...
- plan('multisession') ...
[01:56:53.146] plan(<name>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.146] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ...
[01:56:53.147] | : all.equal() for FutureStrategyList ...
[01:56:53.147] | : . New stack:
[01:56:53.147] | : . List of 1
[01:56:53.147] | : .  $ :function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), 
[01:56:53.147] | : .     gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.147] | : .   ..- attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ...
[01:56:53.147] | : .   ..- attr(*, "init")= logi TRUE
[01:56:53.147] | : .   ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:56:53.147] | : .     gc = FALSE, earlySignal = FALSE, ...)  
[01:56:53.147] | : .   .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.147] | : .   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.147] | : .   ..- attr(*, "untweakable")= chr "persistent"
[01:56:53.147] | : .   ..- attr(*, "call")= language plan(strategy)
[01:56:53.147] | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.151] | : . Old stack:
[01:56:53.151] | : . List of 1
[01:56:53.151] | : .  $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.151] | : .   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.151] | : .   ..- attr(*, "init")= chr "done"
[01:56:53.151] | : .   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.151] | : .   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.151] | : .   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.151] | : .   ..- attr(*, "call")= language plan(sequential)
[01:56:53.151] | : .   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.151] | : .   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.151] | : .   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.151] | : .  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.157] | : . Not identical
[01:56:53.157] | : . all.equal() for future ...
[01:56:53.157] | : . ' List of 2
[01:56:53.157] | : . '  $ target :function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), 
[01:56:53.157] | : . '     gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.157] | : . '   ..- attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ...
[01:56:53.157] | : . '   ..- attr(*, "init")= logi TRUE
[01:56:53.157] | : . '   ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:56:53.157] | : . '     gc = FALSE, earlySignal = FALSE, ...)  
[01:56:53.157] | : . '   .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.157] | : . '   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.157] | : . '   ..- attr(*, "untweakable")= chr "persistent"
[01:56:53.157] | : . '   ..- attr(*, "call")= language plan(strategy)
[01:56:53.157] | : . '  $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.157] | : . '   ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function"
[01:56:53.157] | : . '   ..- attr(*, "init")= chr "done"
[01:56:53.157] | : . '   ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.157] | : . '   .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.157] | : . '   ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.157] | : . '   ..- attr(*, "call")= language plan(sequential)
[01:56:53.157] | : . '   ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' <environment: 0x000002c066143518> 
[01:56:53.157] | : . '   .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf)  
[01:56:53.157] | : . '   .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ...
[01:56:53.164] | : . ' Formals differ
[01:56:53.164] | : . all.equal() for future ... done
[01:56:53.164] | : . Future strategies differ at level 1
[01:56:53.164] | : all.equal() for FutureStrategyList ... done
[01:56:53.164] | : plan(): Setting new future backend stack:
[01:56:53.165] | : List of future strategies:
[01:56:53.165] | : 1. multisession:
[01:56:53.165] | :    - args: function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), gc = FALSE, earlySignal = FALSE, envir = parent.frame())
[01:56:53.165] | :    - tweaked: FALSE
[01:56:53.165] | :    - call: plan(strategy)
[01:56:53.165] | : List of 1
[01:56:53.165] | :  $ :function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), 
[01:56:53.165] | :     gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.165] | :   ..- attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ...
[01:56:53.165] | :   ..- attr(*, "init")= logi TRUE
[01:56:53.165] | :   ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:56:53.165] | :     gc = FALSE, earlySignal = FALSE, ...)  
[01:56:53.165] | :   .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.165] | :   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.165] | :   ..- attr(*, "untweakable")= chr "persistent"
[01:56:53.165] | :   ..- attr(*, "call")= language plan(strategy)
[01:56:53.165] | :  - attr(*, "class")= chr [1:2] "FutureStrategyList" "list"
[01:56:53.169] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ...
[01:56:53.169] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.169] | : . ' Getting current ("next") strategy: 'FutureStrategy', 'sequential', 'uniprocess', 'future', 'function'
[01:56:53.169] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.170] | : . Legacy shutdown of cluster workers ...
[01:56:53.170] | : . ' Stopping existing cluster ...
[01:56:53.170] | : . ' , No pre-existing cluster. Skipping
[01:56:53.170] | : . ' Stopping existing cluster ... done
[01:56:53.170] | : . Legacy shutdown of cluster workers ... done
[01:56:53.171] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... done
[01:56:53.171] | : plan(): plan_init() of 'multisession', 'cluster', 'multiprocess', 'future', 'function' ...
[01:56:53.171] | : . function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), 
[01:56:53.171] | : .     gc = FALSE, earlySignal = FALSE, envir = parent.frame())  
[01:56:53.171] | : .  - attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ...
[01:56:53.171] | : .  - attr(*, "init")= logi TRUE
[01:56:53.171] | : .  - attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, 
[01:56:53.171] | : .     gc = FALSE, earlySignal = FALSE, ...)  
[01:56:53.171] | : .   ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.171] | : .  - attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ...
[01:56:53.171] | : .  - attr(*, "untweakable")= chr "persistent"
[01:56:53.171] | : .  - attr(*, "call")= language plan(strategy)
[01:56:53.174] | : . init: TRUE
[01:56:53.174] | : . makeFutureBackend(<multisession>) ...
[01:56:53.174] | : . ' Backend function: <'NULL'>
[01:56:53.174] | : . ' Evaluator tweak arguments: [n=0]
[01:56:53.174] | : . '  list()
[01:56:53.175] | : . ' Evaluator formal arguments: [n=4]
[01:56:53.175] | : . '  list()
[01:56:53.175] | : . ' Backend factory arguments: [n=4]
[01:56:53.175] | : . ' Dotted pair list of 4
[01:56:53.175] | : . '  $ workers     : language availableCores()
[01:56:53.175] | : . '  $ rscript_libs: language .libPaths()
[01:56:53.175] | : . '  $ gc          : logi FALSE
[01:56:53.175] | : . '  $ earlySignal : logi FALSE
[01:56:53.177] | : . ' MultisessionFutureBackend(workers = <workers>, interrupts = TRUE, ...) ...
[01:56:53.178] | : . ' , Arguments:
[01:56:53.178] | : . ' , List of 5
[01:56:53.178] | : . ' ,  $ workers     : Named int 2
[01:56:53.178] | : . ' ,   ..- attr(*, "names")= chr "mc.cores"
[01:56:53.178] | : . ' ,  $ rscript_libs: chr [1:2] "D:/temp/2025_05_09_01_55_17_23336/RtmpsDakIT/RLIBS_1b6487de1dd0" "D:/RCompile/recent/R/library"
[01:56:53.178] | : . ' ,  $ interrupts  : logi TRUE
[01:56:53.178] | : . ' ,  $ gc          : logi FALSE
[01:56:53.178] | : . ' ,  $ earlySignal : logi FALSE
[01:56:53.183] | : . ' , ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ...
[01:56:53.183] | : . ' , ; workers: 2
[01:56:53.183] | : . ' , ; getCluster() ...
[01:56:53.183] | : . ' , ; getCluster() ... done
[01:56:53.183] | : . ' , ; Stopping existing cluster ...
[01:56:53.183] | : . ' , ; ` No pre-existing cluster. Skipping
[01:56:53.184] | : . ' , ; Stopping existing cluster ... done
[01:56:53.184] | : . ' , ; Starting new cluster ...
[01:56:53.184] | : . ' , ; ` makeCluster(workers, ...) ...
[01:56:53.184] | : . ' , ; ` | Arguments:
[01:56:53.184] | : . ' , ; ` | List of 2
[01:56:53.184] | : . ' , ; ` |  $             : int 2
[01:56:53.184] | : . ' , ; ` |  $ rscript_libs: chr [1:2] "D:/temp/2025_05_09_01_55_17_23336/RtmpsDakIT/RLIBS_1b6487de1dd0" "D:/RCompile/recent/R/library"
[01:56:53.185] | : . ' , ; ` | .makeCluster() ...
[01:56:53.186] | : . ' , ; ` | : workers: '2'
[01:56:53.186] | : . ' , ; ` | : R_FUTURE_PLAN: NA
[01:56:53.186] | : . ' , ; ` | : parallelly::makeClusterPSOCK() arguments:
[01:56:53.186] | : . ' , ; ` | : List of 2
[01:56:53.186] | : . ' , ; ` | :  $             : int 2
[01:56:53.186] | : . ' , ; ` | :  $ rscript_libs: chr [1:2] "D:/temp/2025_05_09_01_55_17_23336/RtmpsDakIT/RLIBS_1b6487de1dd0" "D:/RCompile/recent/R/library"
[01:56:53.772] | : . ' , ; ` | : Generated cluster UUID
[01:56:53.772] | : . ' , ; ` | : Cluster UUID: '19c8999ebf760ab9d0a3abef0fa1f015'
[01:56:53.773] | : . ' , ; ` | : 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:56:53.776] | : . ' , ; ` | .makeCluster() ... done
[01:56:53.776] | : . ' , ; ` | 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:56:53.778] | : . ' , ; ` makeCluster(workers, ...) ... done
[01:56:53.778] | : . ' , ; ` Number of workers: 2
[01:56:53.778] | : . ' , ; ` Workers UUID: '19c8999ebf760ab9d0a3abef0fa1f015'
[01:56:53.778] | : . ' , ; Starting new cluster ... done
[01:56:53.778] | : . ' , ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ... done
[01:56:53.779] | : . ' , Backend: <'MultisessionFutureBackend', 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment'>
[01:56:53.779] | : . ' MultisessionFutureBackend(workers = <workers>, interrupts = TRUE, ...) ... done
[01:56:53.779] | : . makeFutureBackend(<multisession>) ... done
[01:56:53.779] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.779] | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.780] | : . plan(): nbrOfWorkers() = 2
[01:56:53.780] | : plan(): plan_init() of 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... done
[01:56:53.780] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done


	demo(mandelbrot)
	---- ~~~~~~~~~~

> library(future)

> library(graphics)

> plot_what_is_done <- function(counts) {
+   for (kk in seq_along(counts)) {
+     f <- counts[[kk]]
+ 
+     ## Already plotted?
+     if (!inherits(f, "Future")) next
+ 
+     ## Not resolved?
+     if (!resolved(f)) next
+ 
+     message(sprintf("Plotting tile #%d of %d ...", kk, n))
+     counts[[kk]] <- value(f)
+     screen(kk)
+     plot(counts[[kk]])
+   }
+ 
+   counts
+ }

> ## Options
> region <- getOption("future.demo.mandelbrot.region", 1L)

> if (!is.list(region)) {
+   if (region == 1L) {
+     region <- list(xmid = -0.75, ymid = 0.0, side = 3.0)
+   } else if (region == 2L) {
+     region <- list(xmid = 0.283, ymid = -0.0095, side = 0.00026)
+   } else if (region == 3L) {
+     region <- list(xmid = 0.282989, ymid = -0.01, side = 3e-8)
+   }
+ }

> nrow <- getOption("future.demo.mandelbrot.nrow", 3L)

> resolution <- getOption("future.demo.mandelbrot.resolution", 400L)

> delay <- getOption("future.demo.mandelbrot.delay", interactive())

> if (isTRUE(delay)) {
+   delay <- function(counts) Sys.sleep(1.0)
+ } else if (!is.function(delay)) {
+   delay <- function(counts) {}
+ }

> ## Generate Mandelbrot tiles to be computed
> Cs <- mandelbrot_tiles(xmid = region$xmid, ymid = region$ymid,
+                        side = region$side, nrow = nrow,
+                        resolution = resolution)

> if (interactive()) {
+   dev.new()
+   plot.new()
+   split.screen(dim(Cs))
+   for (ii in seq_along(Cs)) {
+     screen(ii)
+     par(mar = c(0, 0, 0, 0))
+     text(x = 1 / 2, y = 1 / 2, sprintf("Future #%d\nunresolved", ii), cex = 2)
+   }
+ } else {
+   split.screen(dim(Cs))
+ }
[1] 5 6 7 8

> ## Create all Mandelbrot tiles via lazy futures
> n <- length(Cs)

> message(sprintf("Creating %d Mandelbrot tiles:", n), appendLF = FALSE)
Creating 4 Mandelbrot tiles:
> counts <- lapply(seq_along(Cs), FUN=function(ii) {
+   message(" ", ii, appendLF = FALSE)
+   C <- Cs[[ii]]
+   future({
+     message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE)
+     fit <- mandelbrot(C)
+ 
+     ## Emulate slowness
+     delay(fit)
+ 
+     message(" done")
+     fit
+   }, lazy = TRUE)
+ })
 1[01:56:53.786] | future(..., label = NULL) ...
[01:56:53.787] | : lazy: TRUE
[01:56:53.787] | : stdout: TRUE
[01:56:53.787] | : conditions: [n=1] 'condition'
[01:56:53.787] | : gc: FALSE
[01:56:53.787] | : earlySignal: FALSE
[01:56:53.787] | : getGlobalsAndPackages() ...
[01:56:53.788] | : . Searching for globals ...
[01:56:53.815] | : . ' globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:53.815] | : . Searching for globals ... done
[01:56:53.816] | : . Resolving globals: FALSE
[01:56:53.816] | : . Search for packages associated with the globals ...
[01:56:53.816] | : . ' Packages associated with globals: [2] 'base', 'future'
[01:56:53.817] | : . ' Packages: [2] 'base', 'future'
[01:56:53.817] | : . Search for packages associated with the globals ... done
[01:56:53.817] | : . Packages after dropping 'base': [1] 'future'
[01:56:53.817] | : . Packages after dropping non-attached packages: [1] 'future'
[01:56:53.818] | : . globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:53.818] | : . packages: [1] 'future'
[01:56:53.818] | : getGlobalsAndPackages() ... done
[01:56:53.818] | future(..., label = NULL) ... done
 2[01:56:53.823] | future(..., label = NULL) ...
[01:56:53.823] | : lazy: TRUE
[01:56:53.823] | : stdout: TRUE
[01:56:53.823] | : conditions: [n=1] 'condition'
[01:56:53.823] | : gc: FALSE
[01:56:53.824] | : earlySignal: FALSE
[01:56:53.824] | : getGlobalsAndPackages() ...
[01:56:53.824] | : . Searching for globals ...
[01:56:53.854] | : . ' globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:53.854] | : . Searching for globals ... done
[01:56:53.855] | : . Resolving globals: FALSE
[01:56:53.855] | : . Search for packages associated with the globals ...
[01:56:53.855] | : . ' Packages associated with globals: [2] 'base', 'future'
[01:56:53.856] | : . ' Packages: [2] 'base', 'future'
[01:56:53.856] | : . Search for packages associated with the globals ... done
[01:56:53.856] | : . Packages after dropping 'base': [1] 'future'
[01:56:53.856] | : . Packages after dropping non-attached packages: [1] 'future'
[01:56:53.856] | : . globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:53.857] | : . packages: [1] 'future'
[01:56:53.857] | : getGlobalsAndPackages() ... done
[01:56:53.857] | future(..., label = NULL) ... done
 3[01:56:53.857] | future(..., label = NULL) ...
[01:56:53.857] | : lazy: TRUE
[01:56:53.858] | : stdout: TRUE
[01:56:53.858] | : conditions: [n=1] 'condition'
[01:56:53.858] | : gc: FALSE
[01:56:53.858] | : earlySignal: FALSE
[01:56:53.858] | : getGlobalsAndPackages() ...
[01:56:53.858] | : . Searching for globals ...
[01:56:53.885] | : . ' globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:53.886] | : . Searching for globals ... done
[01:56:53.886] | : . Resolving globals: FALSE
[01:56:53.886] | : . Search for packages associated with the globals ...
[01:56:53.887] | : . ' Packages associated with globals: [2] 'base', 'future'
[01:56:53.887] | : . ' Packages: [2] 'base', 'future'
[01:56:53.887] | : . Search for packages associated with the globals ... done
[01:56:53.887] | : . Packages after dropping 'base': [1] 'future'
[01:56:53.888] | : . Packages after dropping non-attached packages: [1] 'future'
[01:56:53.888] | : . globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:53.888] | : . packages: [1] 'future'
[01:56:53.888] | : getGlobalsAndPackages() ... done
[01:56:53.888] | future(..., label = NULL) ... done
 4[01:56:53.889] | future(..., label = NULL) ...
[01:56:53.889] | : lazy: TRUE
[01:56:53.889] | : stdout: TRUE
[01:56:53.889] | : conditions: [n=1] 'condition'
[01:56:53.889] | : gc: FALSE
[01:56:53.889] | : earlySignal: FALSE
[01:56:53.890] | : getGlobalsAndPackages() ...
[01:56:53.890] | : . Searching for globals ...
[01:56:53.918] | : . ' globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay'
[01:56:53.919] | : . Searching for globals ... done
[01:56:53.919] | : . Resolving globals: FALSE
[01:56:53.919] | : . Search for packages associated with the globals ...
[01:56:53.919] | : . ' Packages associated with globals: [2] 'base', 'future'
[01:56:53.920] | : . ' Packages: [2] 'base', 'future'
[01:56:53.920] | : . Search for packages associated with the globals ... done
[01:56:53.920] | : . Packages after dropping 'base': [1] 'future'
[01:56:53.920] | : . Packages after dropping non-attached packages: [1] 'future'
[01:56:53.921] | : . globals: [4] 'ii', 'n', 'C', 'delay'
[01:56:53.921] | : . packages: [1] 'future'
[01:56:53.921] | : getGlobalsAndPackages() ... done
[01:56:53.921] | future(..., label = NULL) ... done

> message(".")
.

> ## Calculate and plot tiles
> repeat {
+   counts <- plot_what_is_done(counts)
+   if (!any(sapply(counts, FUN = inherits, "Future"))) break
+ }
[01:56:53.931] | resolved() for Future (NULL) ...
[01:56:53.931] | : state: 'created'
[01:56:53.931] | : run: TRUE
[01:56:53.932] | : run() ...
[01:56:53.932] | : . run() for 'Future' (NULL) ...
[01:56:53.932] | : . ' state: 'created'
[01:56:53.932] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:53.932] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:53.933] | : . ' Using MultisessionFutureBackend ...
[01:56:53.933] | : . ' , Number of futures since start: 0 (0 created, 0 launched, 0 finished)
[01:56:53.933] | : . ' , Launching futures ...
[01:56:53.933] | : . ' , ; launchFuture() for ClusterFutureBackend ...
[01:56:53.934] | : . ' , ; ` Workers: [n=2]
[01:56:53.934] | : . ' , ; ` 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:56:53.936] | : . ' , ; ` FutureRegistry: 'workers-19c8999ebf760ab9d0a3abef0fa1f015'
[01:56:53.936] | : . ' , ; ` requestWorker() ...
[01:56:53.936] | : . ' , ; ` | requestNode() ...
[01:56:53.936] | : . ' , ; ` | : Number of workers: 2
[01:56:53.936] | : . ' , ; ` | : Polling for a free worker ...
[01:56:53.936] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:53.937] | : . ' , ; ` | : . ' Created empty registry 'workers-19c8999ebf760ab9d0a3abef0fa1f015'
[01:56:53.937] | : . ' , ; ` | : . ' Listing all futures
[01:56:53.937] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:53.937] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:53.937] | : . ' , ; ` | : . Total time: 0
[01:56:53.937] | : . ' , ; ` | : Polling for a free worker ... done
[01:56:53.938] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:53.938] | : . ' , ; ` | : . Listing all futures
[01:56:53.938] | : . ' , ; ` | : . Number of registered futures: 0
[01:56:53.938] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:53.938] | : . ' , ; ` | : avail: [n=2] '1', '2'
[01:56:53.938] | : . ' , ; ` | : Index of first available worker: 1
[01:56:53.938] | : . ' , ; ` | : Validate that the worker is functional ...
[01:56:54.082] | : . ' , ; ` | : . Worker is functional
[01:56:54.082] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.082] | : . ' , ; ` | : . ' Listing all futures
[01:56:54.082] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:54.083] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.083] | : . ' , ; ` | : Validate that the worker is functional ... done
[01:56:54.083] | : . ' , ; ` | requestNode() ... done
[01:56:54.083] | : . ' , ; ` | cluster node index: 1
[01:56:54.083] | : . ' , ; ` requestWorker() ... done
[01:56:54.083] | : . ' , ; ` eraseGlobalEnvironment() ...
[01:56:54.084] | : . ' , ; ` eraseGlobalEnvironment() ... done
[01:56:54.084] | : . ' , ; ` launchFuture() ...
[01:56:54.084] | : . ' , ; ` | cluster node index: 1
[01:56:54.085] | : . ' , ; ` | getFutureData() ...
[01:56:54.085] | : . ' , ; ` | : getFutureCore() ...
[01:56:54.085] | : . ' , ; ` | : . Packages needed by the future expression (n = 1): 'future'
[01:56:54.085] | : . ' , ; ` | : getFutureCore() ... done
[01:56:54.085] | : . ' , ; ` | : getFutureCapture() ...
[01:56:54.085] | : . ' , ; ` | : getFutureCapture() ... done
[01:56:54.086] | : . ' , ; ` | : getFutureContext() ...
[01:56:54.086] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:54.086] | : . ' , ; ` | : . ' Getting stack without first backend: [n=0] 
[01:56:54.086] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:54.086] | : . ' , ; ` | : . Packages needed by future backend (n = 0): <none>
[01:56:54.087] | : . ' , ; ` | : getFutureContext() ... done
[01:56:54.087] | : . ' , ; ` | getFutureData() ... done
[01:56:54.088] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ...
[01:56:54.088] | : . ' , ; ` | : Appended future to position #1
[01:56:54.088] | : . ' , ; ` | : Number of registered futures: 1
[01:56:54.088] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ... done
[01:56:54.088] | : . ' , ; ` launchFuture() ... done
[01:56:54.089] | : . ' , ; ` MultisessionFuture started
[01:56:54.089] | : . ' , ; launchFuture() for ClusterFutureBackend ... done
[01:56:54.089] | : . ' , Launching futures ... done
[01:56:54.089] | : . ' , Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:56:54.089] | : . ' Using MultisessionFutureBackend ... done
[01:56:54.089] | : . run() for 'Future' (NULL) ... done
[01:56:54.090] | : run() ... done
[01:56:54.090] | : resolved() ...
[01:56:54.090] | : . resolved() for MultisessionFuture (NULL) ...
[01:56:54.091] | : . ' Cluster node socket connection: index=4, id=342
[01:56:54.091] | : . ' assertValidConnection() ...
[01:56:54.091] | : . ' , cluster node index: 1
[01:56:54.092] | : . ' assertValidConnection() ... done
[01:56:54.198] | : . ' receiveMessageFromWorker() for ClusterFuture ...
[01:56:54.198] | : . ' , cluster node index: 1
[01:56:54.199] | : . ' , [1] TRUE
[01:56:54.199] | : . ' , received data:
[01:56:54.199] | : . ' , List of 5
[01:56:54.199] | : . ' ,  $ type   : chr "VALUE"
[01:56:54.199] | : . ' ,  $ value  :List of 14
[01:56:54.199] | : . ' ,   ..$ value            : 'Mandelbrot' int [1:25, 1:25] 1 1 1 1 1 1 1 1 1 1 ...
[01:56:54.199] | : . ' ,   .. ..- attr(*, "params")=List of 3
[01:56:54.199] | : . ' ,   .. .. ..$ Z      : cplx [1:25, 1:25] -2.25-1.5i -2.25-1.44i -2.25-1.38i ...
[01:56:54.199] | : . ' ,   .. .. .. ..- attr(*, "region")=List of 2
[01:56:54.199] | : . ' ,   .. .. .. .. ..$ xrange: num [1:2] -2.25 -0.781
[01:56:54.199] | : . ' ,   .. .. .. .. ..$ yrange: num [1:2] -1.5 -0.0306
[01:56:54.199] | : . ' ,   .. .. .. ..- attr(*, "tile")= int [1:2] 1 1
[01:56:54.199] | : . ' ,   .. .. ..$ maxIter: int 200
[01:56:54.199] | : . ' ,   .. .. ..$ tau    : num 2
[01:56:54.199] | : . ' ,   ..$ visible          : logi TRUE
[01:56:54.199] | : . ' ,   ..$ stdout           : chr ""
[01:56:54.199] | : . ' ,   ..$ conditions       :List of 2
[01:56:54.199] | : . ' ,   .. ..$ :List of 2
[01:56:54.199] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.199] | : . ' ,   .. .. .. ..$ message: chr "Calculating tile #1 of 4 ..."
[01:56:54.199] | : . ' ,   .. .. .. ..$ call   : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE)
[01:56:54.199] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69
[01:56:54.199] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c06601f158> 
[01:56:54.199] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.199] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.199] | : . ' ,   .. ..$ :List of 2
[01:56:54.199] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.199] | : . ' ,   .. .. .. ..$ message: chr " done\n"
[01:56:54.199] | : . ' ,   .. .. .. ..$ call   : language message(" done")
[01:56:54.199] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75
[01:56:54.199] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c06601f158> 
[01:56:54.199] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.199] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.199] | : . ' ,   ..$ rng              : logi FALSE
[01:56:54.199] | : . ' ,   ..$ misuseGlobalEnv  : NULL
[01:56:54.199] | : . ' ,   ..$ misuseConnections:List of 3
[01:56:54.199] | : . ' ,   .. ..$ added   : NULL
[01:56:54.199] | : . ' ,   .. ..$ removed : NULL
[01:56:54.199] | : . ' ,   .. ..$ replaced: NULL
[01:56:54.199] | : . ' ,   ..$ misuseDevices    : NULL
[01:56:54.199] | : . ' ,   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.199] | : . ' ,   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.199] | : . ' ,   ..$ uuid             : chr [1:2] "001dfd6f50d3360bbb1e2912c4926831" "5"
[01:56:54.199] | : . ' ,   ..$ session_uuid     : chr "bbd305930958ba93debdf76b319023d2"
[01:56:54.199] | : . ' ,   .. ..- attr(*, "source")=List of 5
[01:56:54.199] | : . ' ,   .. .. ..$ host  : Named chr "CRANWIN3"
[01:56:54.199] | : . ' ,   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:56:54.199] | : . ' ,   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:56:54.199] | : . ' ,   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:56:54.199] | : . ' ,   .. .. ..$ pid   : int 181432
[01:56:54.199] | : . ' ,   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.199] | : . ' ,   .. .. ..$ random: int 2147483647
[01:56:54.199] | : . ' ,   ..$ r_info           :List of 4
[01:56:54.199] | : . ' ,   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:56:54.199] | : . ' ,   .. .. ..$ : int [1:3] 4 6 0
[01:56:54.199] | : . ' ,   .. ..$ os           : chr "windows"
[01:56:54.199] | : . ' ,   .. ..$ os_name      : chr "Windows"
[01:56:54.199] | : . ' ,   .. ..$ captures_utf8: logi TRUE
[01:56:54.199] | : . ' ,   ..$ version          : chr "1.8"
[01:56:54.199] | : . ' ,   ..- attr(*, "class")= chr "FutureResult"
[01:56:54.199] | : . ' ,  $ success: logi TRUE
[01:56:54.199] | : . ' ,  $ time   : 'proc_time' Named num [1:5] 0.11 0 0.1 NA NA
[01:56:54.199] | : . ' ,   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:56:54.199] | : . ' ,  $ tag    : NULL
[01:56:54.225] | : . ' , Received FutureResult
[01:56:54.225] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ...
[01:56:54.226] | : . ' , ; Removed future from position #1
[01:56:54.226] | : . ' , ; Number of registered futures: 0
[01:56:54.226] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ... done
[01:56:54.226] | : . ' , Erased future from future backend
[01:56:54.227] | : . ' , result() for ClusterFuture ...
[01:56:54.227] | : . ' , ; result already collected: FutureResult
[01:56:54.227] | : . ' , result() for ClusterFuture ... done
[01:56:54.227] | : . ' , signalConditions() ...
[01:56:54.228] | : . ' , ; include = 'immediateCondition'
[01:56:54.228] | : . ' , ; exclude = 
[01:56:54.228] | : . ' , ; resignal = FALSE
[01:56:54.228] | : . ' , ; Number of conditions: 2
[01:56:54.228] | : . ' , signalConditions() ... done
[01:56:54.229] | : . ' receiveMessageFromWorker() for ClusterFuture ... done
[01:56:54.229] | : . ' receiveMessageFromWorker() returned object of class FutureResult; resolved
[01:56:54.229] | : . resolved() for MultisessionFuture (NULL) ... done
[01:56:54.229] | : . assertFutureResult() ...
[01:56:54.229] | : . ' Future uuid: 001dfd6f50d3360bbb1e2912c4926831[01:56:54.229] | : . ' Future uuid: 5
[01:56:54.230] | : . ' identical; success
[01:56:54.230] | : . assertFutureResult() ... done
[01:56:54.230] | : . resolved: TRUE
[01:56:54.230] | : resolved() ... done
[01:56:54.230] | resolved() for Future (NULL) ... done
Plotting tile #1 of 4 ...
[01:56:54.231] | value() for MultisessionFuture (NULL) ...
[01:56:54.231] | : result() for ClusterFuture ...
[01:56:54.231] | : . result already collected: FutureResult
[01:56:54.231] | : result() for ClusterFuture ... done
[01:56:54.231] | : result() for ClusterFuture ...
[01:56:54.232] | : . result already collected: FutureResult
[01:56:54.232] | : result() for ClusterFuture ... done
[01:56:54.232] | : signalConditions() ...
[01:56:54.232] | : . include = 'immediateCondition'
[01:56:54.232] | : . exclude = 
[01:56:54.233] | : . resignal = FALSE
[01:56:54.233] | : . Number of conditions: 2
[01:56:54.233] | : signalConditions() ... done
[01:56:54.233] | : relay stdout ...
[01:56:54.233] | : relay stdout ... done
[01:56:54.233] | : check for misuse ...
[01:56:54.234] | : check for misuse ... done
[01:56:54.234] | : relay conditions ...
[01:56:54.234] | : . Future state: 'finished'
[01:56:54.234] | : . result() for ClusterFuture ...
[01:56:54.234] | : . ' result already collected: FutureResult
[01:56:54.235] | : . result() for ClusterFuture ... done
[01:56:54.235] | : . signalConditions() ...
[01:56:54.235] | : . ' include = 'condition'
[01:56:54.235] | : . ' exclude = 'immediateCondition'
[01:56:54.235] | : . ' resignal = TRUE
[01:56:54.236] | : . ' Number of conditions: 2
[01:56:54.236] | : . ' Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #1 of 4 ...[01:56:54.236] | : . ' Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:54.236] | : . signalConditions() ... done
[01:56:54.236] | : relay conditions ... done
[01:56:54.237] | value() for MultisessionFuture (NULL) ... done
[01:56:54.238] | resolved() for Future (NULL) ...
[01:56:54.238] | : state: 'created'
[01:56:54.238] | : run: TRUE
[01:56:54.239] | : run() ...
[01:56:54.239] | : . run() for 'Future' (NULL) ...
[01:56:54.239] | : . ' state: 'created'
[01:56:54.240] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:54.240] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:54.240] | : . ' Using MultisessionFutureBackend ...
[01:56:54.240] | : . ' , Number of futures since start: 1 (1 created, 1 launched, 1 finished)
[01:56:54.241] | : . ' , Launching futures ...
[01:56:54.241] | : . ' , ; launchFuture() for ClusterFutureBackend ...
[01:56:54.241] | : . ' , ; ` Workers: [n=2]
[01:56:54.241] | : . ' , ; ` 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:56:54.250] | : . ' , ; ` FutureRegistry: 'workers-19c8999ebf760ab9d0a3abef0fa1f015'
[01:56:54.250] | : . ' , ; ` requestWorker() ...
[01:56:54.250] | : . ' , ; ` | requestNode() ...
[01:56:54.251] | : . ' , ; ` | : Number of workers: 2
[01:56:54.251] | : . ' , ; ` | : Polling for a free worker ...
[01:56:54.251] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.251] | : . ' , ; ` | : . ' Listing all futures
[01:56:54.252] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:54.252] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.252] | : . ' , ; ` | : . Total time: 0
[01:56:54.252] | : . ' , ; ` | : Polling for a free worker ... done
[01:56:54.252] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.253] | : . ' , ; ` | : . Listing all futures
[01:56:54.253] | : . ' , ; ` | : . Number of registered futures: 0
[01:56:54.253] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.253] | : . ' , ; ` | : avail: [n=2] '1', '2'
[01:56:54.253] | : . ' , ; ` | : Index of first available worker: 1
[01:56:54.254] | : . ' , ; ` | : Validate that the worker is functional ...
[01:56:54.299] | : . ' , ; ` | : . Worker is functional
[01:56:54.299] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.300] | : . ' , ; ` | : . ' Listing all futures
[01:56:54.300] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:54.300] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.300] | : . ' , ; ` | : Validate that the worker is functional ... done
[01:56:54.300] | : . ' , ; ` | requestNode() ... done
[01:56:54.301] | : . ' , ; ` | cluster node index: 1
[01:56:54.301] | : . ' , ; ` requestWorker() ... done
[01:56:54.301] | : . ' , ; ` eraseGlobalEnvironment() ...
[01:56:54.302] | : . ' , ; ` eraseGlobalEnvironment() ... done
[01:56:54.302] | : . ' , ; ` launchFuture() ...
[01:56:54.302] | : . ' , ; ` | cluster node index: 1
[01:56:54.302] | : . ' , ; ` | getFutureData() ...
[01:56:54.302] | : . ' , ; ` | : getFutureCore() ...
[01:56:54.303] | : . ' , ; ` | : . Packages needed by the future expression (n = 1): 'future'
[01:56:54.303] | : . ' , ; ` | : getFutureCore() ... done
[01:56:54.303] | : . ' , ; ` | : getFutureCapture() ...
[01:56:54.303] | : . ' , ; ` | : getFutureCapture() ... done
[01:56:54.303] | : . ' , ; ` | : getFutureContext() ...
[01:56:54.304] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:54.304] | : . ' , ; ` | : . ' Getting stack without first backend: [n=0] 
[01:56:54.304] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:54.304] | : . ' , ; ` | : . Packages needed by future backend (n = 0): <none>
[01:56:54.304] | : . ' , ; ` | : getFutureContext() ... done
[01:56:54.305] | : . ' , ; ` | getFutureData() ... done
[01:56:54.305] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ...
[01:56:54.306] | : . ' , ; ` | : Appended future to position #1
[01:56:54.306] | : . ' , ; ` | : Number of registered futures: 1
[01:56:54.306] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ... done
[01:56:54.307] | : . ' , ; ` launchFuture() ... done
[01:56:54.307] | : . ' , ; ` MultisessionFuture started
[01:56:54.307] | : . ' , ; launchFuture() for ClusterFutureBackend ... done
[01:56:54.307] | : . ' , Launching futures ... done
[01:56:54.307] | : . ' , Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:56:54.308] | : . ' Using MultisessionFutureBackend ... done
[01:56:54.308] | : . run() for 'Future' (NULL) ... done
[01:56:54.308] | : run() ... done
[01:56:54.308] | : resolved() ...
[01:56:54.309] | : . resolved() for MultisessionFuture (NULL) ...
[01:56:54.309] | : . ' Cluster node socket connection: index=4, id=342
[01:56:54.310] | : . ' assertValidConnection() ...
[01:56:54.310] | : . ' , cluster node index: 1
[01:56:54.310] | : . ' assertValidConnection() ... done
[01:56:54.317] | : . ' receiveMessageFromWorker() for ClusterFuture ...
[01:56:54.317] | : . ' , cluster node index: 1
[01:56:54.318] | : . ' , [1] TRUE
[01:56:54.318] | : . ' , received data:
[01:56:54.319] | : . ' , List of 5
[01:56:54.319] | : . ' ,  $ type   : chr "VALUE"
[01:56:54.319] | : . ' ,  $ value  :List of 14
[01:56:54.319] | : . ' ,   ..$ value            : 'Mandelbrot' int [1:25, 1:25] 1 1 1 1 2 2 2 2 2 3 ...
[01:56:54.319] | : . ' ,   .. ..- attr(*, "params")=List of 3
[01:56:54.319] | : . ' ,   .. .. ..$ Z      : cplx [1:25, 1:25] -0.719-1.5i -0.719-1.44i -0.719-1.38i ...
[01:56:54.319] | : . ' ,   .. .. .. ..- attr(*, "region")=List of 2
[01:56:54.319] | : . ' ,   .. .. .. .. ..$ xrange: num [1:2] -0.719 0.75
[01:56:54.319] | : . ' ,   .. .. .. .. ..$ yrange: num [1:2] -1.5 -0.0306
[01:56:54.319] | : . ' ,   .. .. .. ..- attr(*, "tile")= int [1:2] 1 2
[01:56:54.319] | : . ' ,   .. .. ..$ maxIter: int 200
[01:56:54.319] | : . ' ,   .. .. ..$ tau    : num 2
[01:56:54.319] | : . ' ,   ..$ visible          : logi TRUE
[01:56:54.319] | : . ' ,   ..$ stdout           : chr ""
[01:56:54.319] | : . ' ,   ..$ conditions       :List of 2
[01:56:54.319] | : . ' ,   .. ..$ :List of 2
[01:56:54.319] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.319] | : . ' ,   .. .. .. ..$ message: chr "Calculating tile #2 of 4 ..."
[01:56:54.319] | : . ' ,   .. .. .. ..$ call   : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE)
[01:56:54.319] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69
[01:56:54.319] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c06728bac0> 
[01:56:54.319] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.319] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.319] | : . ' ,   .. ..$ :List of 2
[01:56:54.319] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.319] | : . ' ,   .. .. .. ..$ message: chr " done\n"
[01:56:54.319] | : . ' ,   .. .. .. ..$ call   : language message(" done")
[01:56:54.319] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75
[01:56:54.319] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c06728bac0> 
[01:56:54.319] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.319] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.319] | : . ' ,   ..$ rng              : logi FALSE
[01:56:54.319] | : . ' ,   ..$ misuseGlobalEnv  : NULL
[01:56:54.319] | : . ' ,   ..$ misuseConnections:List of 3
[01:56:54.319] | : . ' ,   .. ..$ added   : NULL
[01:56:54.319] | : . ' ,   .. ..$ removed : NULL
[01:56:54.319] | : . ' ,   .. ..$ replaced: NULL
[01:56:54.319] | : . ' ,   ..$ misuseDevices    : NULL
[01:56:54.319] | : . ' ,   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.319] | : . ' ,   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.319] | : . ' ,   ..$ uuid             : chr [1:2] "001dfd6f50d3360bbb1e2912c4926831" "6"
[01:56:54.319] | : . ' ,   ..$ session_uuid     : chr "bbd305930958ba93debdf76b319023d2"
[01:56:54.319] | : . ' ,   .. ..- attr(*, "source")=List of 5
[01:56:54.319] | : . ' ,   .. .. ..$ host  : Named chr "CRANWIN3"
[01:56:54.319] | : . ' ,   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:56:54.319] | : . ' ,   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:56:54.319] | : . ' ,   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:56:54.319] | : . ' ,   .. .. ..$ pid   : int 181432
[01:56:54.319] | : . ' ,   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.319] | : . ' ,   .. .. ..$ random: int 2147483647
[01:56:54.319] | : . ' ,   ..$ r_info           :List of 4
[01:56:54.319] | : . ' ,   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:56:54.319] | : . ' ,   .. .. ..$ : int [1:3] 4 6 0
[01:56:54.319] | : . ' ,   .. ..$ os           : chr "windows"
[01:56:54.319] | : . ' ,   .. ..$ os_name      : chr "Windows"
[01:56:54.319] | : . ' ,   .. ..$ captures_utf8: logi TRUE
[01:56:54.319] | : . ' ,   ..$ version          : chr "1.8"
[01:56:54.319] | : . ' ,   ..- attr(*, "class")= chr "FutureResult"
[01:56:54.319] | : . ' ,  $ success: logi TRUE
[01:56:54.319] | : . ' ,  $ time   : 'proc_time' Named num [1:5] 0.01 0 0.01 NA NA
[01:56:54.319] | : . ' ,   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:56:54.319] | : . ' ,  $ tag    : NULL
[01:56:54.342] | : . ' , Received FutureResult
[01:56:54.342] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ...
[01:56:54.342] | : . ' , ; Removed future from position #1
[01:56:54.343] | : . ' , ; Number of registered futures: 0
[01:56:54.343] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ... done
[01:56:54.343] | : . ' , Erased future from future backend
[01:56:54.343] | : . ' , result() for ClusterFuture ...
[01:56:54.343] | : . ' , ; result already collected: FutureResult
[01:56:54.344] | : . ' , result() for ClusterFuture ... done
[01:56:54.344] | : . ' , signalConditions() ...
[01:56:54.344] | : . ' , ; include = 'immediateCondition'
[01:56:54.344] | : . ' , ; exclude = 
[01:56:54.344] | : . ' , ; resignal = FALSE
[01:56:54.344] | : . ' , ; Number of conditions: 2
[01:56:54.345] | : . ' , signalConditions() ... done
[01:56:54.345] | : . ' receiveMessageFromWorker() for ClusterFuture ... done
[01:56:54.345] | : . ' receiveMessageFromWorker() returned object of class FutureResult; resolved
[01:56:54.345] | : . resolved() for MultisessionFuture (NULL) ... done
[01:56:54.345] | : . assertFutureResult() ...
[01:56:54.345] | : . ' Future uuid: 001dfd6f50d3360bbb1e2912c4926831[01:56:54.345] | : . ' Future uuid: 6
[01:56:54.346] | : . ' identical; success
[01:56:54.346] | : . assertFutureResult() ... done
[01:56:54.346] | : . resolved: TRUE
[01:56:54.346] | : resolved() ... done
[01:56:54.346] | resolved() for Future (NULL) ... done
Plotting tile #2 of 4 ...
[01:56:54.347] | value() for MultisessionFuture (NULL) ...
[01:56:54.347] | : result() for ClusterFuture ...
[01:56:54.347] | : . result already collected: FutureResult
[01:56:54.347] | : result() for ClusterFuture ... done
[01:56:54.347] | : result() for ClusterFuture ...
[01:56:54.347] | : . result already collected: FutureResult
[01:56:54.348] | : result() for ClusterFuture ... done
[01:56:54.348] | : signalConditions() ...
[01:56:54.348] | : . include = 'immediateCondition'
[01:56:54.348] | : . exclude = 
[01:56:54.348] | : . resignal = FALSE
[01:56:54.348] | : . Number of conditions: 2
[01:56:54.349] | : signalConditions() ... done
[01:56:54.349] | : relay stdout ...
[01:56:54.349] | : relay stdout ... done
[01:56:54.349] | : check for misuse ...
[01:56:54.349] | : check for misuse ... done
[01:56:54.349] | : relay conditions ...
[01:56:54.350] | : . Future state: 'finished'
[01:56:54.350] | : . result() for ClusterFuture ...
[01:56:54.350] | : . ' result already collected: FutureResult
[01:56:54.350] | : . result() for ClusterFuture ... done
[01:56:54.350] | : . signalConditions() ...
[01:56:54.351] | : . ' include = 'condition'
[01:56:54.351] | : . ' exclude = 'immediateCondition'
[01:56:54.351] | : . ' resignal = TRUE
[01:56:54.351] | : . ' Number of conditions: 2
[01:56:54.351] | : . ' Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #2 of 4 ...[01:56:54.351] | : . ' Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:54.352] | : . signalConditions() ... done
[01:56:54.352] | : relay conditions ... done
[01:56:54.352] | value() for MultisessionFuture (NULL) ... done
[01:56:54.353] | resolved() for Future (NULL) ...
[01:56:54.353] | : state: 'created'
[01:56:54.354] | : run: TRUE
[01:56:54.354] | : run() ...
[01:56:54.354] | : . run() for 'Future' (NULL) ...
[01:56:54.354] | : . ' state: 'created'
[01:56:54.354] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:54.354] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:54.355] | : . ' Using MultisessionFutureBackend ...
[01:56:54.355] | : . ' , Number of futures since start: 2 (2 created, 2 launched, 2 finished)
[01:56:54.355] | : . ' , Launching futures ...
[01:56:54.355] | : . ' , ; launchFuture() for ClusterFutureBackend ...
[01:56:54.355] | : . ' , ; ` Workers: [n=2]
[01:56:54.356] | : . ' , ; ` 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:56:54.358] | : . ' , ; ` FutureRegistry: 'workers-19c8999ebf760ab9d0a3abef0fa1f015'
[01:56:54.358] | : . ' , ; ` requestWorker() ...
[01:56:54.358] | : . ' , ; ` | requestNode() ...
[01:56:54.359] | : . ' , ; ` | : Number of workers: 2
[01:56:54.359] | : . ' , ; ` | : Polling for a free worker ...
[01:56:54.359] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.359] | : . ' , ; ` | : . ' Listing all futures
[01:56:54.359] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:54.360] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.360] | : . ' , ; ` | : . Total time: 0
[01:56:54.360] | : . ' , ; ` | : Polling for a free worker ... done
[01:56:54.360] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.360] | : . ' , ; ` | : . Listing all futures
[01:56:54.360] | : . ' , ; ` | : . Number of registered futures: 0
[01:56:54.361] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.361] | : . ' , ; ` | : avail: [n=2] '1', '2'
[01:56:54.361] | : . ' , ; ` | : Index of first available worker: 1
[01:56:54.361] | : . ' , ; ` | : Validate that the worker is functional ...
[01:56:54.409] | : . ' , ; ` | : . Worker is functional
[01:56:54.409] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.410] | : . ' , ; ` | : . ' Listing all futures
[01:56:54.410] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:54.410] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.410] | : . ' , ; ` | : Validate that the worker is functional ... done
[01:56:54.410] | : . ' , ; ` | requestNode() ... done
[01:56:54.410] | : . ' , ; ` | cluster node index: 1
[01:56:54.411] | : . ' , ; ` requestWorker() ... done
[01:56:54.411] | : . ' , ; ` eraseGlobalEnvironment() ...
[01:56:54.411] | : . ' , ; ` eraseGlobalEnvironment() ... done
[01:56:54.412] | : . ' , ; ` launchFuture() ...
[01:56:54.412] | : . ' , ; ` | cluster node index: 1
[01:56:54.412] | : . ' , ; ` | getFutureData() ...
[01:56:54.412] | : . ' , ; ` | : getFutureCore() ...
[01:56:54.412] | : . ' , ; ` | : . Packages needed by the future expression (n = 1): 'future'
[01:56:54.412] | : . ' , ; ` | : getFutureCore() ... done
[01:56:54.413] | : . ' , ; ` | : getFutureCapture() ...
[01:56:54.413] | : . ' , ; ` | : getFutureCapture() ... done
[01:56:54.413] | : . ' , ; ` | : getFutureContext() ...
[01:56:54.413] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:54.413] | : . ' , ; ` | : . ' Getting stack without first backend: [n=0] 
[01:56:54.414] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:54.414] | : . ' , ; ` | : . Packages needed by future backend (n = 0): <none>
[01:56:54.414] | : . ' , ; ` | : getFutureContext() ... done
[01:56:54.414] | : . ' , ; ` | getFutureData() ... done
[01:56:54.415] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ...
[01:56:54.416] | : . ' , ; ` | : Appended future to position #1
[01:56:54.416] | : . ' , ; ` | : Number of registered futures: 1
[01:56:54.416] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ... done
[01:56:54.416] | : . ' , ; ` launchFuture() ... done
[01:56:54.417] | : . ' , ; ` MultisessionFuture started
[01:56:54.417] | : . ' , ; launchFuture() for ClusterFutureBackend ... done
[01:56:54.417] | : . ' , Launching futures ... done
[01:56:54.417] | : . ' , Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:56:54.418] | : . ' Using MultisessionFutureBackend ... done
[01:56:54.418] | : . run() for 'Future' (NULL) ... done
[01:56:54.418] | : run() ... done
[01:56:54.418] | : resolved() ...
[01:56:54.419] | : . resolved() for MultisessionFuture (NULL) ...
[01:56:54.419] | : . ' Cluster node socket connection: index=4, id=342
[01:56:54.420] | : . ' assertValidConnection() ...
[01:56:54.420] | : . ' , cluster node index: 1
[01:56:54.420] | : . ' assertValidConnection() ... done
[01:56:54.421] | : . ' receiveMessageFromWorker() for ClusterFuture ...
[01:56:54.421] | : . ' , cluster node index: 1
[01:56:54.422] | : . ' , [1] TRUE
[01:56:54.422] | : . ' , received data:
[01:56:54.422] | : . ' , List of 5
[01:56:54.422] | : . ' ,  $ type   : chr "VALUE"
[01:56:54.422] | : . ' ,  $ value  :List of 14
[01:56:54.422] | : . ' ,   ..$ value            : 'Mandelbrot' int [1:25, 1:25] 1 1 1 1 1 1 1 1 1 1 ...
[01:56:54.422] | : . ' ,   .. ..- attr(*, "params")=List of 3
[01:56:54.422] | : . ' ,   .. .. ..$ Z      : cplx [1:25, 1:25] -2.25+0.0306i -2.25+0.0918i -2.25+0.1531i ...
[01:56:54.422] | : . ' ,   .. .. .. ..- attr(*, "region")=List of 2
[01:56:54.422] | : . ' ,   .. .. .. .. ..$ xrange: num [1:2] -2.25 -0.781
[01:56:54.422] | : . ' ,   .. .. .. .. ..$ yrange: num [1:2] 0.0306 1.5
[01:56:54.422] | : . ' ,   .. .. .. ..- attr(*, "tile")= int [1:2] 2 1
[01:56:54.422] | : . ' ,   .. .. ..$ maxIter: int 200
[01:56:54.422] | : . ' ,   .. .. ..$ tau    : num 2
[01:56:54.422] | : . ' ,   ..$ visible          : logi TRUE
[01:56:54.422] | : . ' ,   ..$ stdout           : chr ""
[01:56:54.422] | : . ' ,   ..$ conditions       :List of 2
[01:56:54.422] | : . ' ,   .. ..$ :List of 2
[01:56:54.422] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.422] | : . ' ,   .. .. .. ..$ message: chr "Calculating tile #3 of 4 ..."
[01:56:54.422] | : . ' ,   .. .. .. ..$ call   : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE)
[01:56:54.422] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69
[01:56:54.422] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c063fa3648> 
[01:56:54.422] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.422] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.422] | : . ' ,   .. ..$ :List of 2
[01:56:54.422] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.422] | : . ' ,   .. .. .. ..$ message: chr " done\n"
[01:56:54.422] | : . ' ,   .. .. .. ..$ call   : language message(" done")
[01:56:54.422] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75
[01:56:54.422] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c063fa3648> 
[01:56:54.422] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.422] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.422] | : . ' ,   ..$ rng              : logi FALSE
[01:56:54.422] | : . ' ,   ..$ misuseGlobalEnv  : NULL
[01:56:54.422] | : . ' ,   ..$ misuseConnections:List of 3
[01:56:54.422] | : . ' ,   .. ..$ added   : NULL
[01:56:54.422] | : . ' ,   .. ..$ removed : NULL
[01:56:54.422] | : . ' ,   .. ..$ replaced: NULL
[01:56:54.422] | : . ' ,   ..$ misuseDevices    : NULL
[01:56:54.422] | : . ' ,   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.422] | : . ' ,   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.422] | : . ' ,   ..$ uuid             : chr [1:2] "001dfd6f50d3360bbb1e2912c4926831" "7"
[01:56:54.422] | : . ' ,   ..$ session_uuid     : chr "bbd305930958ba93debdf76b319023d2"
[01:56:54.422] | : . ' ,   .. ..- attr(*, "source")=List of 5
[01:56:54.422] | : . ' ,   .. .. ..$ host  : Named chr "CRANWIN3"
[01:56:54.422] | : . ' ,   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:56:54.422] | : . ' ,   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:56:54.422] | : . ' ,   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:56:54.422] | : . ' ,   .. .. ..$ pid   : int 181432
[01:56:54.422] | : . ' ,   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.422] | : . ' ,   .. .. ..$ random: int 2147483647
[01:56:54.422] | : . ' ,   ..$ r_info           :List of 4
[01:56:54.422] | : . ' ,   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:56:54.422] | : . ' ,   .. .. ..$ : int [1:3] 4 6 0
[01:56:54.422] | : . ' ,   .. ..$ os           : chr "windows"
[01:56:54.422] | : . ' ,   .. ..$ os_name      : chr "Windows"
[01:56:54.422] | : . ' ,   .. ..$ captures_utf8: logi TRUE
[01:56:54.422] | : . ' ,   ..$ version          : chr "1.8"
[01:56:54.422] | : . ' ,   ..- attr(*, "class")= chr "FutureResult"
[01:56:54.422] | : . ' ,  $ success: logi TRUE
[01:56:54.422] | : . ' ,  $ time   : 'proc_time' Named num [1:5] 0.02 0 0.01 NA NA
[01:56:54.422] | : . ' ,   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:56:54.422] | : . ' ,  $ tag    : NULL
[01:56:54.454] | : . ' , Received FutureResult
[01:56:54.454] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ...
[01:56:54.454] | : . ' , ; Removed future from position #1
[01:56:54.455] | : . ' , ; Number of registered futures: 0
[01:56:54.455] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ... done
[01:56:54.455] | : . ' , Erased future from future backend
[01:56:54.455] | : . ' , result() for ClusterFuture ...
[01:56:54.456] | : . ' , ; result already collected: FutureResult
[01:56:54.456] | : . ' , result() for ClusterFuture ... done
[01:56:54.456] | : . ' , signalConditions() ...
[01:56:54.456] | : . ' , ; include = 'immediateCondition'
[01:56:54.456] | : . ' , ; exclude = 
[01:56:54.456] | : . ' , ; resignal = FALSE
[01:56:54.457] | : . ' , ; Number of conditions: 2
[01:56:54.457] | : . ' , signalConditions() ... done
[01:56:54.457] | : . ' receiveMessageFromWorker() for ClusterFuture ... done
[01:56:54.457] | : . ' receiveMessageFromWorker() returned object of class FutureResult; resolved
[01:56:54.457] | : . resolved() for MultisessionFuture (NULL) ... done
[01:56:54.457] | : . assertFutureResult() ...
[01:56:54.458] | : . ' Future uuid: 001dfd6f50d3360bbb1e2912c4926831[01:56:54.458] | : . ' Future uuid: 7
[01:56:54.458] | : . ' identical; success
[01:56:54.458] | : . assertFutureResult() ... done
[01:56:54.458] | : . resolved: TRUE
[01:56:54.458] | : resolved() ... done
[01:56:54.459] | resolved() for Future (NULL) ... done
Plotting tile #3 of 4 ...
[01:56:54.459] | value() for MultisessionFuture (NULL) ...
[01:56:54.459] | : result() for ClusterFuture ...
[01:56:54.459] | : . result already collected: FutureResult
[01:56:54.459] | : result() for ClusterFuture ... done
[01:56:54.460] | : result() for ClusterFuture ...
[01:56:54.460] | : . result already collected: FutureResult
[01:56:54.460] | : result() for ClusterFuture ... done
[01:56:54.460] | : signalConditions() ...
[01:56:54.460] | : . include = 'immediateCondition'
[01:56:54.461] | : . exclude = 
[01:56:54.461] | : . resignal = FALSE
[01:56:54.461] | : . Number of conditions: 2
[01:56:54.461] | : signalConditions() ... done
[01:56:54.461] | : relay stdout ...
[01:56:54.462] | : relay stdout ... done
[01:56:54.462] | : check for misuse ...
[01:56:54.462] | : check for misuse ... done
[01:56:54.462] | : relay conditions ...
[01:56:54.463] | : . Future state: 'finished'
[01:56:54.463] | : . result() for ClusterFuture ...
[01:56:54.463] | : . ' result already collected: FutureResult
[01:56:54.463] | : . result() for ClusterFuture ... done
[01:56:54.463] | : . signalConditions() ...
[01:56:54.464] | : . ' include = 'condition'
[01:56:54.464] | : . ' exclude = 'immediateCondition'
[01:56:54.464] | : . ' resignal = TRUE
[01:56:54.464] | : . ' Number of conditions: 2
[01:56:54.464] | : . ' Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #3 of 4 ...[01:56:54.464] | : . ' Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:54.465] | : . signalConditions() ... done
[01:56:54.465] | : relay conditions ... done
[01:56:54.465] | value() for MultisessionFuture (NULL) ... done
[01:56:54.466] | resolved() for Future (NULL) ...
[01:56:54.466] | : state: 'created'
[01:56:54.466] | : run: TRUE
[01:56:54.466] | : run() ...
[01:56:54.467] | : . run() for 'Future' (NULL) ...
[01:56:54.467] | : . ' state: 'created'
[01:56:54.467] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:54.467] | : . ' plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:54.467] | : . ' Using MultisessionFutureBackend ...
[01:56:54.467] | : . ' , Number of futures since start: 3 (3 created, 3 launched, 3 finished)
[01:56:54.468] | : . ' , Launching futures ...
[01:56:54.468] | : . ' , ; launchFuture() for ClusterFutureBackend ...
[01:56:54.468] | : . ' , ; ` Workers: [n=2]
[01:56:54.468] | : . ' , ; ` 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:56:54.470] | : . ' , ; ` FutureRegistry: 'workers-19c8999ebf760ab9d0a3abef0fa1f015'
[01:56:54.471] | : . ' , ; ` requestWorker() ...
[01:56:54.471] | : . ' , ; ` | requestNode() ...
[01:56:54.471] | : . ' , ; ` | : Number of workers: 2
[01:56:54.471] | : . ' , ; ` | : Polling for a free worker ...
[01:56:54.471] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.471] | : . ' , ; ` | : . ' Listing all futures
[01:56:54.472] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:54.472] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.472] | : . ' , ; ` | : . Total time: 0
[01:56:54.472] | : . ' , ; ` | : Polling for a free worker ... done
[01:56:54.472] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.472] | : . ' , ; ` | : . Listing all futures
[01:56:54.473] | : . ' , ; ` | : . Number of registered futures: 0
[01:56:54.473] | : . ' , ; ` | : FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.473] | : . ' , ; ` | : avail: [n=2] '1', '2'
[01:56:54.473] | : . ' , ; ` | : Index of first available worker: 1
[01:56:54.473] | : . ' , ; ` | : Validate that the worker is functional ...
[01:56:54.520] | : . ' , ; ` | : . Worker is functional
[01:56:54.520] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ...
[01:56:54.520] | : . ' , ; ` | : . ' Listing all futures
[01:56:54.521] | : . ' , ; ` | : . ' Number of registered futures: 0
[01:56:54.521] | : . ' , ; ` | : . FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'list', earlySignal = 0) ... done
[01:56:54.521] | : . ' , ; ` | : Validate that the worker is functional ... done
[01:56:54.521] | : . ' , ; ` | requestNode() ... done
[01:56:54.521] | : . ' , ; ` | cluster node index: 1
[01:56:54.522] | : . ' , ; ` requestWorker() ... done
[01:56:54.522] | : . ' , ; ` eraseGlobalEnvironment() ...
[01:56:54.522] | : . ' , ; ` eraseGlobalEnvironment() ... done
[01:56:54.523] | : . ' , ; ` launchFuture() ...
[01:56:54.523] | : . ' , ; ` | cluster node index: 1
[01:56:54.523] | : . ' , ; ` | getFutureData() ...
[01:56:54.523] | : . ' , ; ` | : getFutureCore() ...
[01:56:54.523] | : . ' , ; ` | : . Packages needed by the future expression (n = 1): 'future'
[01:56:54.523] | : . ' , ; ` | : getFutureCore() ... done
[01:56:54.524] | : . ' , ; ` | : getFutureCapture() ...
[01:56:54.524] | : . ' , ; ` | : getFutureCapture() ... done
[01:56:54.524] | : . ' , ; ` | : getFutureContext() ...
[01:56:54.524] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ...
[01:56:54.524] | : . ' , ; ` | : . ' Getting stack without first backend: [n=0] 
[01:56:54.524] | : . ' , ; ` | : . plan(<character>, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done
[01:56:54.525] | : . ' , ; ` | : . Packages needed by future backend (n = 0): <none>
[01:56:54.525] | : . ' , ; ` | : getFutureContext() ... done
[01:56:54.525] | : . ' , ; ` | getFutureData() ... done
[01:56:54.526] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ...
[01:56:54.526] | : . ' , ; ` | : Appended future to position #1
[01:56:54.526] | : . ' , ; ` | : Number of registered futures: 1
[01:56:54.526] | : . ' , ; ` | FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'add', earlySignal = 0) ... done
[01:56:54.527] | : . ' , ; ` launchFuture() ... done
[01:56:54.527] | : . ' , ; ` MultisessionFuture started
[01:56:54.527] | : . ' , ; launchFuture() for ClusterFutureBackend ... done
[01:56:54.527] | : . ' , Launching futures ... done
[01:56:54.527] | : . ' , Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future'
[01:56:54.527] | : . ' Using MultisessionFutureBackend ... done
[01:56:54.528] | : . run() for 'Future' (NULL) ... done
[01:56:54.528] | : run() ... done
[01:56:54.528] | : resolved() ...
[01:56:54.528] | : . resolved() for MultisessionFuture (NULL) ...
[01:56:54.529] | : . ' Cluster node socket connection: index=4, id=342
[01:56:54.529] | : . ' assertValidConnection() ...
[01:56:54.529] | : . ' , cluster node index: 1
[01:56:54.529] | : . ' assertValidConnection() ... done
[01:56:54.535] | : . ' receiveMessageFromWorker() for ClusterFuture ...
[01:56:54.535] | : . ' , cluster node index: 1
[01:56:54.536] | : . ' , [1] TRUE
[01:56:54.536] | : . ' , received data:
[01:56:54.536] | : . ' , List of 5
[01:56:54.536] | : . ' ,  $ type   : chr "VALUE"
[01:56:54.536] | : . ' ,  $ value  :List of 14
[01:56:54.536] | : . ' ,   ..$ value            : 'Mandelbrot' int [1:25, 1:25] 200 200 200 109 195 15 9 8 5 5 ...
[01:56:54.536] | : . ' ,   .. ..- attr(*, "params")=List of 3
[01:56:54.536] | : . ' ,   .. .. ..$ Z      : cplx [1:25, 1:25] -0.719+0.0306i -0.719+0.0918i -0.719+0.1531i ...
[01:56:54.536] | : . ' ,   .. .. .. ..- attr(*, "region")=List of 2
[01:56:54.536] | : . ' ,   .. .. .. .. ..$ xrange: num [1:2] -0.719 0.75
[01:56:54.536] | : . ' ,   .. .. .. .. ..$ yrange: num [1:2] 0.0306 1.5
[01:56:54.536] | : . ' ,   .. .. .. ..- attr(*, "tile")= int [1:2] 2 2
[01:56:54.536] | : . ' ,   .. .. ..$ maxIter: int 200
[01:56:54.536] | : . ' ,   .. .. ..$ tau    : num 2
[01:56:54.536] | : . ' ,   ..$ visible          : logi TRUE
[01:56:54.536] | : . ' ,   ..$ stdout           : chr ""
[01:56:54.536] | : . ' ,   ..$ conditions       :List of 2
[01:56:54.536] | : . ' ,   .. ..$ :List of 2
[01:56:54.536] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.536] | : . ' ,   .. .. .. ..$ message: chr "Calculating tile #4 of 4 ..."
[01:56:54.536] | : . ' ,   .. .. .. ..$ call   : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE)
[01:56:54.536] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69
[01:56:54.536] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c06679bdd0> 
[01:56:54.536] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.536] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.536] | : . ' ,   .. ..$ :List of 2
[01:56:54.536] | : . ' ,   .. .. ..$ condition:List of 2
[01:56:54.536] | : . ' ,   .. .. .. ..$ message: chr " done\n"
[01:56:54.536] | : . ' ,   .. .. .. ..$ call   : language message(" done")
[01:56:54.536] | : . ' ,   .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75
[01:56:54.536] | : . ' ,   .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' <environment: 0x000002c06679bdd0> 
[01:56:54.536] | : . ' ,   .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition"
[01:56:54.536] | : . ' ,   .. .. ..$ signaled : int 0
[01:56:54.536] | : . ' ,   ..$ rng              : logi FALSE
[01:56:54.536] | : . ' ,   ..$ misuseGlobalEnv  : NULL
[01:56:54.536] | : . ' ,   ..$ misuseConnections:List of 3
[01:56:54.536] | : . ' ,   .. ..$ added   : NULL
[01:56:54.536] | : . ' ,   .. ..$ removed : NULL
[01:56:54.536] | : . ' ,   .. ..$ replaced: NULL
[01:56:54.536] | : . ' ,   ..$ misuseDevices    : NULL
[01:56:54.536] | : . ' ,   ..$ started          : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.536] | : . ' ,   ..$ finished         : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.536] | : . ' ,   ..$ uuid             : chr [1:2] "001dfd6f50d3360bbb1e2912c4926831" "8"
[01:56:54.536] | : . ' ,   ..$ session_uuid     : chr "bbd305930958ba93debdf76b319023d2"
[01:56:54.536] | : . ' ,   .. ..- attr(*, "source")=List of 5
[01:56:54.536] | : . ' ,   .. .. ..$ host  : Named chr "CRANWIN3"
[01:56:54.536] | : . ' ,   .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME"
[01:56:54.536] | : . ' ,   .. .. ..$ info  : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ...
[01:56:54.536] | : . ' ,   .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ...
[01:56:54.536] | : . ' ,   .. .. ..$ pid   : int 181432
[01:56:54.536] | : . ' ,   .. .. ..$ time  : POSIXct[1:1], format: "2025-05-09 01:56:54"
[01:56:54.536] | : . ' ,   .. .. ..$ random: int 2147483647
[01:56:54.536] | : . ' ,   ..$ r_info           :List of 4
[01:56:54.536] | : . ' ,   .. ..$ version      :Classes 'R_system_version', 'package_version', 'numeric_version'  hidden list of 1
[01:56:54.536] | : . ' ,   .. .. ..$ : int [1:3] 4 6 0
[01:56:54.536] | : . ' ,   .. ..$ os           : chr "windows"
[01:56:54.536] | : . ' ,   .. ..$ os_name      : chr "Windows"
[01:56:54.536] | : . ' ,   .. ..$ captures_utf8: logi TRUE
[01:56:54.536] | : . ' ,   ..$ version          : chr "1.8"
[01:56:54.536] | : . ' ,   ..- attr(*, "class")= chr "FutureResult"
[01:56:54.536] | : . ' ,  $ success: logi TRUE
[01:56:54.536] | : . ' ,  $ time   : 'proc_time' Named num [1:5] 0 0 0 NA NA
[01:56:54.536] | : . ' ,   ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ...
[01:56:54.536] | : . ' ,  $ tag    : NULL
[01:56:54.559] | : . ' , Received FutureResult
[01:56:54.559] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ...
[01:56:54.559] | : . ' , ; Removed future from position #1
[01:56:54.560] | : . ' , ; Number of registered futures: 0
[01:56:54.560] | : . ' , FutureRegistry('workers-19c8999ebf760ab9d0a3abef0fa1f015', action = 'remove', earlySignal = 0) ... done
[01:56:54.560] | : . ' , Erased future from future backend
[01:56:54.560] | : . ' , result() for ClusterFuture ...
[01:56:54.560] | : . ' , ; result already collected: FutureResult
[01:56:54.560] | : . ' , result() for ClusterFuture ... done
[01:56:54.561] | : . ' , signalConditions() ...
[01:56:54.561] | : . ' , ; include = 'immediateCondition'
[01:56:54.561] | : . ' , ; exclude = 
[01:56:54.561] | : . ' , ; resignal = FALSE
[01:56:54.561] | : . ' , ; Number of conditions: 2
[01:56:54.561] | : . ' , signalConditions() ... done
[01:56:54.562] | : . ' receiveMessageFromWorker() for ClusterFuture ... done
[01:56:54.562] | : . ' receiveMessageFromWorker() returned object of class FutureResult; resolved
[01:56:54.562] | : . resolved() for MultisessionFuture (NULL) ... done
[01:56:54.562] | : . assertFutureResult() ...
[01:56:54.562] | : . ' Future uuid: 001dfd6f50d3360bbb1e2912c4926831[01:56:54.562] | : . ' Future uuid: 8
[01:56:54.562] | : . ' identical; success
[01:56:54.563] | : . assertFutureResult() ... done
[01:56:54.563] | : . resolved: TRUE
[01:56:54.563] | : resolved() ... done
[01:56:54.563] | resolved() for Future (NULL) ... done
Plotting tile #4 of 4 ...
[01:56:54.563] | value() for MultisessionFuture (NULL) ...
[01:56:54.563] | : result() for ClusterFuture ...
[01:56:54.564] | : . result already collected: FutureResult
[01:56:54.564] | : result() for ClusterFuture ... done
[01:56:54.564] | : result() for ClusterFuture ...
[01:56:54.564] | : . result already collected: FutureResult
[01:56:54.564] | : result() for ClusterFuture ... done
[01:56:54.564] | : signalConditions() ...
[01:56:54.565] | : . include = 'immediateCondition'
[01:56:54.565] | : . exclude = 
[01:56:54.565] | : . resignal = FALSE
[01:56:54.565] | : . Number of conditions: 2
[01:56:54.565] | : signalConditions() ... done
[01:56:54.565] | : relay stdout ...
[01:56:54.566] | : relay stdout ... done
[01:56:54.566] | : check for misuse ...
[01:56:54.566] | : check for misuse ... done
[01:56:54.566] | : relay conditions ...
[01:56:54.566] | : . Future state: 'finished'
[01:56:54.566] | : . result() for ClusterFuture ...
[01:56:54.566] | : . ' result already collected: FutureResult
[01:56:54.567] | : . result() for ClusterFuture ... done
[01:56:54.567] | : . signalConditions() ...
[01:56:54.567] | : . ' include = 'condition'
[01:56:54.567] | : . ' exclude = 'immediateCondition'
[01:56:54.567] | : . ' resignal = TRUE
[01:56:54.567] | : . ' Number of conditions: 2
[01:56:54.568] | : . ' Condition #1: 'simpleMessage', 'message', 'condition'
Calculating tile #4 of 4 ...[01:56:54.568] | : . ' Condition #2: 'simpleMessage', 'message', 'condition'
 done
[01:56:54.568] | : . signalConditions() ... done
[01:56:54.568] | : relay conditions ... done
[01:56:54.568] | value() for MultisessionFuture (NULL) ... done

> close.screen()
[1] 1 2 3 4 5 6 7 8

> message("SUGGESTION: Try to rerun this demo after changing strategy for how futures are resolved, e.g. plan(multisession).\n")
SUGGESTION: Try to rerun this demo after changing strategy for how futures are resolved, e.g. plan(multisession).

- plan('multisession') ... DONE
Testing with 2 cores ... DONE

> message("*** Mandelbrot demo of the 'future' package ... DONE")
*** Mandelbrot demo of the 'future' package ... 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_05_09_01_55_17_23336'
Sourcing 6 epilogue scripts ... done
Test time: user.self=1s, sys.self=0.08s, elapsed=2s, user.child=NAs, sys.child=NAs
Test 'demo-mandelbrot' ... success
> 
> proc.time()
   user  system elapsed 
   1.56    0.12    2.36