R version 4.5.0 RC (2025-04-04 r88126 ucrt) -- "How About a Twenty-Six" 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 incl/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) [08:47:10.116] Option 'future.startup.script': TRUE [08:47:10.118] Future startup scripts considered: '.future.R', '~/.future.R' [08:47:10.118] Future startup scripts found: > 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') ... [08:47:10.128] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.129] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... [08:47:10.129] | : all.equal() for FutureStrategyList ... [08:47:10.130] | : . New stack: [08:47:10.130] | : . List of 1 [08:47:10.130] | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.130] | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.130] | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.130] | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.130] | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.130] | : . ..- attr(*, "call")= language plan(strategy) [08:47:10.130] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.138] | : . Old stack: [08:47:10.138] | : . List of 1 [08:47:10.138] | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.138] | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.138] | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.138] | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.138] | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.138] | : . ..- attr(*, "call")= language plan(sequential) [08:47:10.138] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.147] | : . Not identical [08:47:10.147] | : . all.equal() for future ... [08:47:10.147] | : . | List of 2 [08:47:10.147] | : . | $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.147] | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.147] | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.147] | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.147] | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.147] | : . | ..- attr(*, "call")= language plan(strategy) [08:47:10.147] | : . | $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.147] | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.147] | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.147] | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.147] | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.147] | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.157] | : . all.equal() for future ... done [08:47:10.157] | : all.equal() for FutureStrategyList ... done [08:47:10.157] | : plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.157] | : List of future strategies: [08:47:10.157] | : 1. sequential: [08:47:10.157] | : - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.157] | : - tweaked: FALSE [08:47:10.157] | : - call: plan(sequential) [08:47:10.159] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done [08:47:10.159] plan(, .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[08:47:10.259] getGlobalsAndPackages() ... [08:47:10.260] | Searching for globals ... [08:47:10.285] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:10.286] | Searching for globals ... DONE [08:47:10.286] | Resolving globals: FALSE [08:47:10.287] | Search for packages associated with the globals ... [08:47:10.287] | : Packages associated with globals: [2] 'base', 'future' [08:47:10.289] | : Packages: [2] 'base', 'future' [08:47:10.289] | Search for packages associated with the globals ... DONE [08:47:10.290] | Packages after dropping 'base': [1] 'future' [08:47:10.290] | Packages after dropping non-attached packages: [1] 'future' [08:47:10.291] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:10.291] | packages: [1] 'future' [08:47:10.291] getGlobalsAndPackages() ... done 2[08:47:10.301] getGlobalsAndPackages() ... [08:47:10.302] | Searching for globals ... [08:47:10.310] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:10.311] | Searching for globals ... DONE [08:47:10.311] | Resolving globals: FALSE [08:47:10.311] | Search for packages associated with the globals ... [08:47:10.312] | : Packages associated with globals: [2] 'base', 'future' [08:47:10.313] | : Packages: [2] 'base', 'future' [08:47:10.313] | Search for packages associated with the globals ... DONE [08:47:10.314] | Packages after dropping 'base': [1] 'future' [08:47:10.314] | Packages after dropping non-attached packages: [1] 'future' [08:47:10.315] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:10.315] | packages: [1] 'future' [08:47:10.316] getGlobalsAndPackages() ... done 3[08:47:10.316] getGlobalsAndPackages() ... [08:47:10.317] | Searching for globals ... [08:47:10.328] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:10.329] | Searching for globals ... DONE [08:47:10.329] | Resolving globals: FALSE [08:47:10.329] | Search for packages associated with the globals ... [08:47:10.330] | : Packages associated with globals: [2] 'base', 'future' [08:47:10.331] | : Packages: [2] 'base', 'future' [08:47:10.331] | Search for packages associated with the globals ... DONE [08:47:10.332] | Packages after dropping 'base': [1] 'future' [08:47:10.332] | Packages after dropping non-attached packages: [1] 'future' [08:47:10.332] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:10.333] | packages: [1] 'future' [08:47:10.333] getGlobalsAndPackages() ... done 4[08:47:10.334] getGlobalsAndPackages() ... [08:47:10.334] | Searching for globals ... [08:47:10.341] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:10.341] | Searching for globals ... DONE [08:47:10.341] | Resolving globals: FALSE [08:47:10.342] | Search for packages associated with the globals ... [08:47:10.342] | : Packages associated with globals: [2] 'base', 'future' [08:47:10.343] | : Packages: [2] 'base', 'future' [08:47:10.343] | Search for packages associated with the globals ... DONE [08:47:10.344] | Packages after dropping 'base': [1] 'future' [08:47:10.344] | Packages after dropping non-attached packages: [1] 'future' [08:47:10.344] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:10.345] | packages: [1] 'future' [08:47:10.345] getGlobalsAndPackages() ... done > message(".") . > ## Calculate and plot tiles > repeat { + counts <- plot_what_is_done(counts) + if (!any(sapply(counts, FUN = inherits, "Future"))) break + } [08:47:10.370] resolved() for 'Future' ... [08:47:10.371] | state: 'created' [08:47:10.371] | run: TRUE [08:47:10.372] | run() ... [08:47:10.372] | : run() for Future ('Future') ... [08:47:10.373] | : . state: 'created' [08:47:10.373] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.374] | : . | makeFutureBackend() ... [08:47:10.374] | : . | : Backend function: <'NULL'> [08:47:10.375] | : . | : Backend: <'SequentialFutureBackend', 'FutureBackend', 'environment'> [08:47:10.375] | : . | makeFutureBackend() ... done [08:47:10.375] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.376] | : . Using SequentialFutureBackend ... [08:47:10.376] | : . | Launching futures ... [08:47:10.377] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [08:47:10.377] | : . | : . getFutureData() ... [08:47:10.378] | : . | : . | getFutureCore() ... [08:47:10.378] | : . | : . | : Packages needed by the future expression (n = 1): 'future' [08:47:10.378] | : . | : . | getFutureCore() ... done [08:47:10.379] | : . | : . | getFutureCapture() ... [08:47:10.379] | : . | : . | getFutureCapture() ... done [08:47:10.380] | : . | : . | getFutureContext() ... [08:47:10.380] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.381] | : . | : . | : . Getting stack without first strategy: [n=0] [08:47:10.381] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.381] | : . | : . | : Packages needed by future strategies (n = 0): [08:47:10.382] | : . | : . | getFutureContext() ... done [08:47:10.382] | : . | : . getFutureData() ... done [08:47:10.384] | : . | : . attachPackages() ... [08:47:10.385] | : . | : . | packages: [n=1] 'future' [08:47:10.385] | : . | : . attachPackages() ... DONE [08:47:10.386] | : . | : . attachPackages() ... [08:47:10.386] | : . | : . | packages: [n=1] 'future' [08:47:10.386] | : . | : . attachPackages() ... DONE [08:47:10.387] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.388] | : . | : . | Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [08:47:10.388] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.389] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.390] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.390] | : . | : . | : all.equal() for FutureStrategyList ... [08:47:10.391] | : . | : . | : . New stack: [08:47:10.391] | : . | : . | : . List of 1 [08:47:10.391] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.391] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.391] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.391] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.391] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.391] | : . | : . | : . ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.391] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.469] | : . | : . | : . Old stack: [08:47:10.469] | : . | : . | : . List of 1 [08:47:10.469] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.469] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.469] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.469] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.469] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.469] | : . | : . | : . ..- attr(*, "call")= language plan(sequential) [08:47:10.469] | : . | : . | : . ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.469] | : . | : . | : . .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.469] | : . | : . | : . .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.469] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.478] | : . | : . | : . Not identical [08:47:10.479] | : . | : . | : . all.equal() for future ... [08:47:10.479] | : . | : . | : . | List of 2 [08:47:10.479] | : . | : . | : . | $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.479] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.479] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.479] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.479] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.479] | : . | : . | : . | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.479] | : . | : . | : . | $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.479] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.479] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.479] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.479] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.479] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.479] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.479] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.479] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.491] | : . | : . | : . all.equal() for future ... done [08:47:10.492] | : . | : . | : all.equal() for FutureStrategyList ... done [08:47:10.492] | : . | : . | : plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.492] | : . | : . | : List of future strategies: [08:47:10.492] | : . | : . | : 1. sequential: [08:47:10.492] | : . | : . | : - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.492] | : . | : . | : - tweaked: FALSE [08:47:10.492] | : . | : . | : - call: plan(sequential) [08:47:10.494] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.494] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.495] | : . | : . assign_globals() ... [08:47:10.495] | : . | : . List of 4 [08:47:10.495] | : . | : . $ ii : int 1 [08:47:10.495] | : . | : . $ n : int 4 [08:47:10.495] | : . | : . $ C : cplx [1:25, 1:25] -2.25-1.5i -2.25-1.44i -2.25-1.38i ... [08:47:10.495] | : . | : . ..- attr(*, "region")=List of 2 [08:47:10.495] | : . | : . .. ..$ xrange: num [1:2] -2.25 -0.781 [08:47:10.495] | : . | : . .. ..$ yrange: num [1:2] -1.5 -0.0306 [08:47:10.495] | : . | : . ..- attr(*, "tile")= int [1:2] 1 1 [08:47:10.495] | : . | : . $ delay:function (counts) [08:47:10.495] | : . | : . ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41 [08:47:10.495] | : . | : . .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:10.495] | : . | : . - attr(*, "where")=List of 4 [08:47:10.495] | : . | : . ..$ ii : [08:47:10.495] | : . | : . ..$ n : [08:47:10.495] | : . | : . ..$ C : [08:47:10.495] | : . | : . ..$ delay: [08:47:10.495] | : . | : . - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list" [08:47:10.495] | : . | : . - attr(*, "resolved")= logi FALSE [08:47:10.495] | : . | : . - attr(*, "total_size")= num NA [08:47:10.495] | : . | : . - attr(*, "already-done")= logi TRUE [08:47:10.568] | : . | : . - copied 'ii' to environment [08:47:10.568] | : . | : . - copied 'n' to environment [08:47:10.568] | : . | : . - copied 'C' to environment [08:47:10.569] | : . | : . - reassign environment for 'delay' [where=emptyenv()] [08:47:10.569] | : . | : . - copied 'delay' to environment [08:47:10.569] | : . | : . assign_globals() ... done [08:47:10.577] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.577] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.577] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.578] | : . | : . | : . all.equal() for FutureStrategyList ... [08:47:10.578] | : . | : . | : . | New stack: [08:47:10.578] | : . | : . | : . | List of 1 [08:47:10.578] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.578] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.578] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.578] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.578] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.578] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.578] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.578] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.578] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.578] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.584] | : . | : . | : . | Old stack: [08:47:10.584] | : . | : . | : . | List of 1 [08:47:10.584] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.584] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.584] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.584] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.584] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.584] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.584] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.584] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.584] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.584] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.589] | : . | : . | : . | Identical [08:47:10.590] | : . | : . | : . all.equal() for FutureStrategyList ... done [08:47:10.590] | : . | : . | : . plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.590] | : . | : . | : . List of future strategies: [08:47:10.590] | : . | : . | : . 1. sequential: [08:47:10.590] | : . | : . | : . - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.590] | : . | : . | : . - tweaked: FALSE [08:47:10.590] | : . | : . | : . - call: plan(sequential) [08:47:10.591] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.591] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.592] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.592] | : . | : . SequentialFuture started (and completed) [08:47:10.593] | : . | : . signalConditions() ... [08:47:10.593] | : . | : . | include = 'immediateCondition' [08:47:10.594] | : . | : . | exclude = [08:47:10.594] | : . | : . | resignal = FALSE [08:47:10.594] | : . | : . | Number of conditions: 2 [08:47:10.595] | : . | : . signalConditions() ... done [08:47:10.595] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... DONE [08:47:10.595] | : . | Launching futures ... done [08:47:10.595] | : . | Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [08:47:10.596] | : . Using SequentialFutureBackend ... done [08:47:10.596] | : run() for Future ('SequentialFuture') ... done [08:47:10.596] | run() ... done [08:47:10.597] | resolved() ... [08:47:10.597] | : resolved() for 'SequentialFuture' ... [08:47:10.597] | : . state: 'finished' [08:47:10.598] | : . run: TRUE [08:47:10.598] | : . result: 'FutureResult' [08:47:10.598] | : resolved() for 'SequentialFuture' ... done [08:47:10.598] | : resolved: TRUE [08:47:10.599] | resolved() ... done [08:47:10.599] resolved() for 'SequentialFuture' ... done Plotting tile #1 of 4 ... [08:47:10.600] signalConditions() ... [08:47:10.600] | include = 'immediateCondition' [08:47:10.601] | exclude = [08:47:10.601] | resignal = FALSE [08:47:10.601] | Number of conditions: 2 [08:47:10.602] signalConditions() ... done [08:47:10.602] Future state: 'finished' [08:47:10.602] signalConditions() ... [08:47:10.603] | include = 'condition' [08:47:10.603] | exclude = 'immediateCondition' [08:47:10.603] | resignal = TRUE [08:47:10.603] | Number of conditions: 2 [08:47:10.604] | Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #1 of 4 ...[08:47:10.604] | Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:10.605] signalConditions() ... done [08:47:10.607] resolved() for 'Future' ... [08:47:10.608] | state: 'created' [08:47:10.608] | run: TRUE [08:47:10.608] | run() ... [08:47:10.609] | : run() for Future ('Future') ... [08:47:10.609] | : . state: 'created' [08:47:10.609] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.610] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.610] | : . Using SequentialFutureBackend ... [08:47:10.610] | : . | Launching futures ... [08:47:10.610] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [08:47:10.611] | : . | : . getFutureData() ... [08:47:10.611] | : . | : . | getFutureCore() ... [08:47:10.611] | : . | : . | : Packages needed by the future expression (n = 1): 'future' [08:47:10.612] | : . | : . | getFutureCore() ... done [08:47:10.612] | : . | : . | getFutureCapture() ... [08:47:10.612] | : . | : . | getFutureCapture() ... done [08:47:10.612] | : . | : . | getFutureContext() ... [08:47:10.613] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.613] | : . | : . | : . Getting stack without first strategy: [n=0] [08:47:10.613] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.614] | : . | : . | : Packages needed by future strategies (n = 0): [08:47:10.614] | : . | : . | getFutureContext() ... done [08:47:10.614] | : . | : . getFutureData() ... done [08:47:10.615] | : . | : . attachPackages() ... [08:47:10.615] | : . | : . | packages: [n=1] 'future' [08:47:10.615] | : . | : . attachPackages() ... DONE [08:47:10.616] | : . | : . attachPackages() ... [08:47:10.616] | : . | : . | packages: [n=1] 'future' [08:47:10.616] | : . | : . attachPackages() ... DONE [08:47:10.617] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.618] | : . | : . | Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [08:47:10.618] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.619] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.619] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.619] | : . | : . | : all.equal() for FutureStrategyList ... [08:47:10.620] | : . | : . | : . New stack: [08:47:10.620] | : . | : . | : . List of 1 [08:47:10.620] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.620] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.620] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.620] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.620] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.620] | : . | : . | : . ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.620] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.625] | : . | : . | : . Old stack: [08:47:10.625] | : . | : . | : . List of 1 [08:47:10.625] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.625] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.625] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.625] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.625] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.625] | : . | : . | : . ..- attr(*, "call")= language plan(sequential) [08:47:10.625] | : . | : . | : . ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.625] | : . | : . | : . .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.625] | : . | : . | : . .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.625] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.631] | : . | : . | : . Not identical [08:47:10.631] | : . | : . | : . all.equal() for future ... [08:47:10.631] | : . | : . | : . | List of 2 [08:47:10.631] | : . | : . | : . | $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.631] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.631] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.631] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.631] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.631] | : . | : . | : . | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.631] | : . | : . | : . | $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.631] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.631] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.631] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.631] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.631] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.631] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.631] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.631] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.641] | : . | : . | : . all.equal() for future ... done [08:47:10.641] | : . | : . | : all.equal() for FutureStrategyList ... done [08:47:10.641] | : . | : . | : plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.642] | : . | : . | : List of future strategies: [08:47:10.642] | : . | : . | : 1. sequential: [08:47:10.642] | : . | : . | : - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.642] | : . | : . | : - tweaked: FALSE [08:47:10.642] | : . | : . | : - call: plan(sequential) [08:47:10.643] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.643] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.644] | : . | : . assign_globals() ... [08:47:10.644] | : . | : . List of 4 [08:47:10.644] | : . | : . $ ii : int 2 [08:47:10.644] | : . | : . $ n : int 4 [08:47:10.644] | : . | : . $ C : cplx [1:25, 1:25] -0.719-1.5i -0.719-1.44i -0.719-1.38i ... [08:47:10.644] | : . | : . ..- attr(*, "region")=List of 2 [08:47:10.644] | : . | : . .. ..$ xrange: num [1:2] -0.719 0.75 [08:47:10.644] | : . | : . .. ..$ yrange: num [1:2] -1.5 -0.0306 [08:47:10.644] | : . | : . ..- attr(*, "tile")= int [1:2] 1 2 [08:47:10.644] | : . | : . $ delay:function (counts) [08:47:10.644] | : . | : . ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41 [08:47:10.644] | : . | : . .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:10.644] | : . | : . - attr(*, "where")=List of 4 [08:47:10.644] | : . | : . ..$ ii : [08:47:10.644] | : . | : . ..$ n : [08:47:10.644] | : . | : . ..$ C : [08:47:10.644] | : . | : . ..$ delay: [08:47:10.644] | : . | : . - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list" [08:47:10.644] | : . | : . - attr(*, "resolved")= logi FALSE [08:47:10.644] | : . | : . - attr(*, "total_size")= num NA [08:47:10.644] | : . | : . - attr(*, "already-done")= logi TRUE [08:47:10.658] | : . | : . - copied 'ii' to environment [08:47:10.659] | : . | : . - copied 'n' to environment [08:47:10.659] | : . | : . - copied 'C' to environment [08:47:10.659] | : . | : . - reassign environment for 'delay' [where=emptyenv()] [08:47:10.660] | : . | : . - copied 'delay' to environment [08:47:10.660] | : . | : . assign_globals() ... done [08:47:10.668] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.669] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.669] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.669] | : . | : . | : . all.equal() for FutureStrategyList ... [08:47:10.670] | : . | : . | : . | New stack: [08:47:10.670] | : . | : . | : . | List of 1 [08:47:10.670] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.670] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.670] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.670] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.670] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.670] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.670] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.670] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.670] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.670] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.677] | : . | : . | : . | Old stack: [08:47:10.678] | : . | : . | : . | List of 1 [08:47:10.678] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.678] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.678] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.678] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.678] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.678] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.678] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.678] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.678] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.678] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.684] | : . | : . | : . | Identical [08:47:10.685] | : . | : . | : . all.equal() for FutureStrategyList ... done [08:47:10.685] | : . | : . | : . plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.685] | : . | : . | : . List of future strategies: [08:47:10.685] | : . | : . | : . 1. sequential: [08:47:10.685] | : . | : . | : . - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.685] | : . | : . | : . - tweaked: FALSE [08:47:10.685] | : . | : . | : . - call: plan(sequential) [08:47:10.687] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.687] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.687] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.688] | : . | : . SequentialFuture started (and completed) [08:47:10.688] | : . | : . signalConditions() ... [08:47:10.689] | : . | : . | include = 'immediateCondition' [08:47:10.689] | : . | : . | exclude = [08:47:10.689] | : . | : . | resignal = FALSE [08:47:10.690] | : . | : . | Number of conditions: 2 [08:47:10.690] | : . | : . signalConditions() ... done [08:47:10.690] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... DONE [08:47:10.691] | : . | Launching futures ... done [08:47:10.691] | : . | Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [08:47:10.691] | : . Using SequentialFutureBackend ... done [08:47:10.692] | : run() for Future ('SequentialFuture') ... done [08:47:10.692] | run() ... done [08:47:10.692] | resolved() ... [08:47:10.693] | : resolved() for 'SequentialFuture' ... [08:47:10.693] | : . state: 'finished' [08:47:10.694] | : . run: TRUE [08:47:10.694] | : . result: 'FutureResult' [08:47:10.694] | : resolved() for 'SequentialFuture' ... done [08:47:10.695] | : resolved: TRUE [08:47:10.695] | resolved() ... done [08:47:10.695] resolved() for 'SequentialFuture' ... done Plotting tile #2 of 4 ... [08:47:10.696] signalConditions() ... [08:47:10.696] | include = 'immediateCondition' [08:47:10.696] | exclude = [08:47:10.697] | resignal = FALSE [08:47:10.697] | Number of conditions: 2 [08:47:10.697] signalConditions() ... done [08:47:10.698] Future state: 'finished' [08:47:10.698] signalConditions() ... [08:47:10.698] | include = 'condition' [08:47:10.699] | exclude = 'immediateCondition' [08:47:10.699] | resignal = TRUE [08:47:10.699] | Number of conditions: 2 [08:47:10.700] | Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #2 of 4 ...[08:47:10.700] | Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:10.701] signalConditions() ... done [08:47:10.702] resolved() for 'Future' ... [08:47:10.702] | state: 'created' [08:47:10.703] | run: TRUE [08:47:10.703] | run() ... [08:47:10.703] | : run() for Future ('Future') ... [08:47:10.703] | : . state: 'created' [08:47:10.703] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.704] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.704] | : . Using SequentialFutureBackend ... [08:47:10.704] | : . | Launching futures ... [08:47:10.704] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [08:47:10.705] | : . | : . getFutureData() ... [08:47:10.705] | : . | : . | getFutureCore() ... [08:47:10.705] | : . | : . | : Packages needed by the future expression (n = 1): 'future' [08:47:10.706] | : . | : . | getFutureCore() ... done [08:47:10.706] | : . | : . | getFutureCapture() ... [08:47:10.706] | : . | : . | getFutureCapture() ... done [08:47:10.707] | : . | : . | getFutureContext() ... [08:47:10.707] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.707] | : . | : . | : . Getting stack without first strategy: [n=0] [08:47:10.708] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.708] | : . | : . | : Packages needed by future strategies (n = 0): [08:47:10.708] | : . | : . | getFutureContext() ... done [08:47:10.708] | : . | : . getFutureData() ... done [08:47:10.709] | : . | : . attachPackages() ... [08:47:10.709] | : . | : . | packages: [n=1] 'future' [08:47:10.709] | : . | : . attachPackages() ... DONE [08:47:10.710] | : . | : . attachPackages() ... [08:47:10.710] | : . | : . | packages: [n=1] 'future' [08:47:10.710] | : . | : . attachPackages() ... DONE [08:47:10.711] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.711] | : . | : . | Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [08:47:10.712] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.713] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.713] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.713] | : . | : . | : all.equal() for FutureStrategyList ... [08:47:10.714] | : . | : . | : . New stack: [08:47:10.714] | : . | : . | : . List of 1 [08:47:10.714] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.714] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.714] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.714] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.714] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.714] | : . | : . | : . ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.714] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.717] | : . | : . | : . Old stack: [08:47:10.718] | : . | : . | : . List of 1 [08:47:10.718] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.718] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.718] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.718] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.718] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.718] | : . | : . | : . ..- attr(*, "call")= language plan(sequential) [08:47:10.718] | : . | : . | : . ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.718] | : . | : . | : . .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.718] | : . | : . | : . .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.718] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.724] | : . | : . | : . Not identical [08:47:10.724] | : . | : . | : . all.equal() for future ... [08:47:10.724] | : . | : . | : . | List of 2 [08:47:10.724] | : . | : . | : . | $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.724] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.724] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.724] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.724] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.724] | : . | : . | : . | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.724] | : . | : . | : . | $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.724] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.724] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.724] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.724] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.724] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.724] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.724] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.724] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.737] | : . | : . | : . all.equal() for future ... done [08:47:10.738] | : . | : . | : all.equal() for FutureStrategyList ... done [08:47:10.738] | : . | : . | : plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.738] | : . | : . | : List of future strategies: [08:47:10.738] | : . | : . | : 1. sequential: [08:47:10.738] | : . | : . | : - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.738] | : . | : . | : - tweaked: FALSE [08:47:10.738] | : . | : . | : - call: plan(sequential) [08:47:10.739] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.739] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.740] | : . | : . assign_globals() ... [08:47:10.740] | : . | : . List of 4 [08:47:10.740] | : . | : . $ ii : int 3 [08:47:10.740] | : . | : . $ n : int 4 [08:47:10.740] | : . | : . $ C : cplx [1:25, 1:25] -2.25+0.0306i -2.25+0.0918i -2.25+0.1531i ... [08:47:10.740] | : . | : . ..- attr(*, "region")=List of 2 [08:47:10.740] | : . | : . .. ..$ xrange: num [1:2] -2.25 -0.781 [08:47:10.740] | : . | : . .. ..$ yrange: num [1:2] 0.0306 1.5 [08:47:10.740] | : . | : . ..- attr(*, "tile")= int [1:2] 2 1 [08:47:10.740] | : . | : . $ delay:function (counts) [08:47:10.740] | : . | : . ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41 [08:47:10.740] | : . | : . .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:10.740] | : . | : . - attr(*, "where")=List of 4 [08:47:10.740] | : . | : . ..$ ii : [08:47:10.740] | : . | : . ..$ n : [08:47:10.740] | : . | : . ..$ C : [08:47:10.740] | : . | : . ..$ delay: [08:47:10.740] | : . | : . - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list" [08:47:10.740] | : . | : . - attr(*, "resolved")= logi FALSE [08:47:10.740] | : . | : . - attr(*, "total_size")= num NA [08:47:10.740] | : . | : . - attr(*, "already-done")= logi TRUE [08:47:10.750] | : . | : . - copied 'ii' to environment [08:47:10.751] | : . | : . - copied 'n' to environment [08:47:10.751] | : . | : . - copied 'C' to environment [08:47:10.751] | : . | : . - reassign environment for 'delay' [where=emptyenv()] [08:47:10.751] | : . | : . - copied 'delay' to environment [08:47:10.752] | : . | : . assign_globals() ... done [08:47:10.757] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.757] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.758] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.758] | : . | : . | : . all.equal() for FutureStrategyList ... [08:47:10.758] | : . | : . | : . | New stack: [08:47:10.758] | : . | : . | : . | List of 1 [08:47:10.758] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.758] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.758] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.758] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.758] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.758] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.758] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.758] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.758] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.758] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.764] | : . | : . | : . | Old stack: [08:47:10.764] | : . | : . | : . | List of 1 [08:47:10.764] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.764] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.764] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.764] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.764] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.764] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.764] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.764] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.764] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.764] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.769] | : . | : . | : . | Identical [08:47:10.770] | : . | : . | : . all.equal() for FutureStrategyList ... done [08:47:10.770] | : . | : . | : . plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.770] | : . | : . | : . List of future strategies: [08:47:10.770] | : . | : . | : . 1. sequential: [08:47:10.770] | : . | : . | : . - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.770] | : . | : . | : . - tweaked: FALSE [08:47:10.770] | : . | : . | : . - call: plan(sequential) [08:47:10.771] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.771] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.772] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.772] | : . | : . SequentialFuture started (and completed) [08:47:10.772] | : . | : . signalConditions() ... [08:47:10.773] | : . | : . | include = 'immediateCondition' [08:47:10.773] | : . | : . | exclude = [08:47:10.773] | : . | : . | resignal = FALSE [08:47:10.773] | : . | : . | Number of conditions: 2 [08:47:10.774] | : . | : . signalConditions() ... done [08:47:10.774] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... DONE [08:47:10.774] | : . | Launching futures ... done [08:47:10.775] | : . | Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [08:47:10.775] | : . Using SequentialFutureBackend ... done [08:47:10.775] | : run() for Future ('SequentialFuture') ... done [08:47:10.775] | run() ... done [08:47:10.776] | resolved() ... [08:47:10.776] | : resolved() for 'SequentialFuture' ... [08:47:10.776] | : . state: 'finished' [08:47:10.776] | : . run: TRUE [08:47:10.777] | : . result: 'FutureResult' [08:47:10.777] | : resolved() for 'SequentialFuture' ... done [08:47:10.777] | : resolved: TRUE [08:47:10.777] | resolved() ... done [08:47:10.778] resolved() for 'SequentialFuture' ... done Plotting tile #3 of 4 ... [08:47:10.778] signalConditions() ... [08:47:10.778] | include = 'immediateCondition' [08:47:10.779] | exclude = [08:47:10.779] | resignal = FALSE [08:47:10.779] | Number of conditions: 2 [08:47:10.779] signalConditions() ... done [08:47:10.780] Future state: 'finished' [08:47:10.780] signalConditions() ... [08:47:10.780] | include = 'condition' [08:47:10.780] | exclude = 'immediateCondition' [08:47:10.781] | resignal = TRUE [08:47:10.781] | Number of conditions: 2 [08:47:10.781] | Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #3 of 4 ...[08:47:10.782] | Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:10.782] signalConditions() ... done [08:47:10.783] resolved() for 'Future' ... [08:47:10.783] | state: 'created' [08:47:10.784] | run: TRUE [08:47:10.784] | run() ... [08:47:10.784] | : run() for Future ('Future') ... [08:47:10.784] | : . state: 'created' [08:47:10.785] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.785] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.785] | : . Using SequentialFutureBackend ... [08:47:10.785] | : . | Launching futures ... [08:47:10.786] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [08:47:10.786] | : . | : . getFutureData() ... [08:47:10.786] | : . | : . | getFutureCore() ... [08:47:10.787] | : . | : . | : Packages needed by the future expression (n = 1): 'future' [08:47:10.787] | : . | : . | getFutureCore() ... done [08:47:10.787] | : . | : . | getFutureCapture() ... [08:47:10.787] | : . | : . | getFutureCapture() ... done [08:47:10.788] | : . | : . | getFutureContext() ... [08:47:10.788] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.788] | : . | : . | : . Getting stack without first strategy: [n=0] [08:47:10.788] | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.789] | : . | : . | : Packages needed by future strategies (n = 0): [08:47:10.789] | : . | : . | getFutureContext() ... done [08:47:10.789] | : . | : . getFutureData() ... done [08:47:10.789] | : . | : . attachPackages() ... [08:47:10.790] | : . | : . | packages: [n=1] 'future' [08:47:10.790] | : . | : . attachPackages() ... DONE [08:47:10.790] | : . | : . attachPackages() ... [08:47:10.791] | : . | : . | packages: [n=1] 'future' [08:47:10.791] | : . | : . attachPackages() ... DONE [08:47:10.792] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.792] | : . | : . | Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [08:47:10.792] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.793] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.793] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.793] | : . | : . | : all.equal() for FutureStrategyList ... [08:47:10.794] | : . | : . | : . New stack: [08:47:10.794] | : . | : . | : . List of 1 [08:47:10.794] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.794] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.794] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.794] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.794] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.794] | : . | : . | : . ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.794] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.798] | : . | : . | : . Old stack: [08:47:10.798] | : . | : . | : . List of 1 [08:47:10.798] | : . | : . | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.798] | : . | : . | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.798] | : . | : . | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.798] | : . | : . | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.798] | : . | : . | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.798] | : . | : . | : . ..- attr(*, "call")= language plan(sequential) [08:47:10.798] | : . | : . | : . ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.798] | : . | : . | : . .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.798] | : . | : . | : . .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.798] | : . | : . | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.804] | : . | : . | : . Not identical [08:47:10.804] | : . | : . | : . all.equal() for future ... [08:47:10.804] | : . | : . | : . | List of 2 [08:47:10.804] | : . | : . | : . | $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.804] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.804] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.804] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.804] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.804] | : . | : . | : . | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [08:47:10.804] | : . | : . | : . | $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.804] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.804] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.804] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.804] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.804] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.804] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.804] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.804] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.813] | : . | : . | : . all.equal() for future ... done [08:47:10.813] | : . | : . | : all.equal() for FutureStrategyList ... done [08:47:10.813] | : . | : . | : plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.814] | : . | : . | : List of future strategies: [08:47:10.814] | : . | : . | : 1. sequential: [08:47:10.814] | : . | : . | : - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.814] | : . | : . | : - tweaked: FALSE [08:47:10.814] | : . | : . | : - call: plan(sequential) [08:47:10.815] | : . | : . | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.815] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.815] | : . | : . assign_globals() ... [08:47:10.816] | : . | : . List of 4 [08:47:10.816] | : . | : . $ ii : int 4 [08:47:10.816] | : . | : . $ n : int 4 [08:47:10.816] | : . | : . $ C : cplx [1:25, 1:25] -0.719+0.0306i -0.719+0.0918i -0.719+0.1531i ... [08:47:10.816] | : . | : . ..- attr(*, "region")=List of 2 [08:47:10.816] | : . | : . .. ..$ xrange: num [1:2] -0.719 0.75 [08:47:10.816] | : . | : . .. ..$ yrange: num [1:2] 0.0306 1.5 [08:47:10.816] | : . | : . ..- attr(*, "tile")= int [1:2] 2 2 [08:47:10.816] | : . | : . $ delay:function (counts) [08:47:10.816] | : . | : . ..- attr(*, "srcref")= 'srcref' int [1:8] 41 12 41 30 12 30 41 41 [08:47:10.816] | : . | : . .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:10.816] | : . | : . - attr(*, "where")=List of 4 [08:47:10.816] | : . | : . ..$ ii : [08:47:10.816] | : . | : . ..$ n : [08:47:10.816] | : . | : . ..$ C : [08:47:10.816] | : . | : . ..$ delay: [08:47:10.816] | : . | : . - attr(*, "class")= chr [1:3] "FutureGlobals" "Globals" "list" [08:47:10.816] | : . | : . - attr(*, "resolved")= logi FALSE [08:47:10.816] | : . | : . - attr(*, "total_size")= num NA [08:47:10.816] | : . | : . - attr(*, "already-done")= logi TRUE [08:47:10.827] | : . | : . - copied 'ii' to environment [08:47:10.827] | : . | : . - copied 'n' to environment [08:47:10.828] | : . | : . - copied 'C' to environment [08:47:10.828] | : . | : . - reassign environment for 'delay' [where=emptyenv()] [08:47:10.828] | : . | : . - copied 'delay' to environment [08:47:10.828] | : . | : . assign_globals() ... done [08:47:10.835] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.836] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [08:47:10.836] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [08:47:10.836] | : . | : . | : . all.equal() for FutureStrategyList ... [08:47:10.836] | : . | : . | : . | New stack: [08:47:10.837] | : . | : . | : . | List of 1 [08:47:10.837] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.837] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.837] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.837] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.837] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.837] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.837] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.837] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.837] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.837] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.843] | : . | : . | : . | Old stack: [08:47:10.843] | : . | : . | : . | List of 1 [08:47:10.843] | : . | : . | : . | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.843] | : . | : . | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.843] | : . | : . | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.843] | : . | : . | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.843] | : . | : . | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.843] | : . | : . | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.843] | : . | : . | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.843] | : . | : . | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.843] | : . | : . | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.843] | : . | : . | : . | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.848] | : . | : . | : . | Identical [08:47:10.849] | : . | : . | : . all.equal() for FutureStrategyList ... done [08:47:10.849] | : . | : . | : . plan(): Skip setting new future strategy stack because it is the same as the current one: [08:47:10.849] | : . | : . | : . List of future strategies: [08:47:10.849] | : . | : . | : . 1. sequential: [08:47:10.849] | : . | : . | : . - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [08:47:10.849] | : . | : . | : . - tweaked: FALSE [08:47:10.849] | : . | : . | : . - call: plan(sequential) [08:47:10.850] | : . | : . | : plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [08:47:10.850] | : . | : . | plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.851] | : . | : . plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [08:47:10.851] | : . | : . SequentialFuture started (and completed) [08:47:10.852] | : . | : . signalConditions() ... [08:47:10.852] | : . | : . | include = 'immediateCondition' [08:47:10.852] | : . | : . | exclude = [08:47:10.853] | : . | : . | resignal = FALSE [08:47:10.853] | : . | : . | Number of conditions: 2 [08:47:10.853] | : . | : . signalConditions() ... done [08:47:10.853] | : . | : launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... DONE [08:47:10.854] | : . | Launching futures ... done [08:47:10.854] | : . | Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [08:47:10.854] | : . Using SequentialFutureBackend ... done [08:47:10.855] | : run() for Future ('SequentialFuture') ... done [08:47:10.855] | run() ... done [08:47:10.855] | resolved() ... [08:47:10.855] | : resolved() for 'SequentialFuture' ... [08:47:10.856] | : . state: 'finished' [08:47:10.856] | : . run: TRUE [08:47:10.856] | : . result: 'FutureResult' [08:47:10.857] | : resolved() for 'SequentialFuture' ... done [08:47:10.857] | : resolved: TRUE [08:47:10.857] | resolved() ... done [08:47:10.857] resolved() for 'SequentialFuture' ... done Plotting tile #4 of 4 ... [08:47:10.858] signalConditions() ... [08:47:10.858] | include = 'immediateCondition' [08:47:10.858] | exclude = [08:47:10.859] | resignal = FALSE [08:47:10.859] | Number of conditions: 2 [08:47:10.859] signalConditions() ... done [08:47:10.860] Future state: 'finished' [08:47:10.860] signalConditions() ... [08:47:10.860] | include = 'condition' [08:47:10.860] | exclude = 'immediateCondition' [08:47:10.861] | resignal = TRUE [08:47:10.861] | Number of conditions: 2 [08:47:10.861] | Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #4 of 4 ...[08:47:10.862] | Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:10.862] signalConditions() ... 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') ... [08:47:10.868] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.869] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... [08:47:10.869] | : all.equal() for FutureStrategyList ... [08:47:10.870] | : . New stack: [08:47:10.870] | : . List of 1 [08:47:10.870] | : . $ :function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), [08:47:10.870] | : . gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.870] | : . ..- attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ... [08:47:10.870] | : . ..- attr(*, "init")= logi TRUE [08:47:10.870] | : . ..- attr(*, "factory")=function (workers = availableCores(), interrupts = TRUE, ...) [08:47:10.870] | : . .. ..- attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.870] | : . ..- attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.870] | : . ..- attr(*, "untweakable")= chr "persistent" [08:47:10.870] | : . ..- attr(*, "call")= language plan(strategy) [08:47:10.870] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.876] | : . Old stack: [08:47:10.876] | : . List of 1 [08:47:10.876] | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.876] | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.876] | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.876] | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.876] | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.876] | : . ..- attr(*, "call")= language plan(sequential) [08:47:10.876] | : . ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.876] | : . .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.876] | : . .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.876] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.882] | : . Not identical [08:47:10.882] | : . all.equal() for future ... [08:47:10.883] | : . | List of 2 [08:47:10.883] | : . | $ target :function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), [08:47:10.883] | : . | gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.883] | : . | ..- attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ... [08:47:10.883] | : . | ..- attr(*, "init")= logi TRUE [08:47:10.883] | : . | ..- attr(*, "factory")=function (workers = availableCores(), interrupts = TRUE, ...) [08:47:10.883] | : . | .. ..- attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.883] | : . | ..- attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.883] | : . | ..- attr(*, "untweakable")= chr "persistent" [08:47:10.883] | : . | ..- attr(*, "call")= language plan(strategy) [08:47:10.883] | : . | $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.883] | : . | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [08:47:10.883] | : . | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.883] | : . | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.883] | : . | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.883] | : . | ..- attr(*, "call")= language plan(sequential) [08:47:10.883] | : . | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [08:47:10.883] | : . | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [08:47:10.883] | : . | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [08:47:10.896] | : . | Formals differ [08:47:10.897] | : . all.equal() for future ... done [08:47:10.897] | : . Future strategies differ at level 1 [08:47:10.897] | : all.equal() for FutureStrategyList ... done [08:47:10.897] | : plan(): Setting new future strategy stack: [08:47:10.898] | : List of future strategies: [08:47:10.898] | : 1. multisession: [08:47:10.898] | : - args: function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.898] | : - tweaked: FALSE [08:47:10.898] | : - call: plan(strategy) [08:47:10.898] | : List of 1 [08:47:10.898] | : $ :function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), [08:47:10.898] | : gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.898] | : ..- attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ... [08:47:10.898] | : ..- attr(*, "init")= logi TRUE [08:47:10.898] | : ..- attr(*, "factory")=function (workers = availableCores(), interrupts = TRUE, ...) [08:47:10.898] | : .. ..- attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.898] | : ..- attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.898] | : ..- attr(*, "untweakable")= chr "persistent" [08:47:10.898] | : ..- attr(*, "call")= language plan(strategy) [08:47:10.898] | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [08:47:10.904] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... [08:47:10.904] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:10.905] | : . | Getting current ("next") strategy: 'FutureStrategy', 'sequential', 'uniprocess', 'future', 'function' [08:47:10.905] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:10.905] | : . Legacy shutdown of cluster workers ... [08:47:10.906] | : . | Stopping existing cluster ... [08:47:10.906] | : . | : No pre-existing cluster. Skipping [08:47:10.906] | : . | Stopping existing cluster ... done [08:47:10.907] | : . Legacy shutdown of cluster workers ... done [08:47:10.907] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... done [08:47:10.907] | : plan(): plan_init() of 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... [08:47:10.908] | : . function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), [08:47:10.908] | : . gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [08:47:10.908] | : . - attr(*, "class")= chr [1:5] "multisession" "cluster" "multiprocess" "future" ... [08:47:10.908] | : . - attr(*, "init")= logi TRUE [08:47:10.908] | : . - attr(*, "factory")=function (workers = availableCores(), interrupts = TRUE, ...) [08:47:10.908] | : . ..- attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.908] | : . - attr(*, "tweakable")= chr [1:10] "workers" "interrupts" "gc" "earlySignal" ... [08:47:10.908] | : . - attr(*, "untweakable")= chr "persistent" [08:47:10.908] | : . - attr(*, "call")= language plan(strategy) [08:47:10.912] | : . init: TRUE [08:47:10.912] | : . makeFutureBackend() ... [08:47:10.913] | : . | Backend function: <'NULL'> [08:47:10.916] | : . | ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ... [08:47:10.916] | : . | : workers: 2 [08:47:10.916] | : . | : getCluster() ... [08:47:10.916] | : . | : getCluster() ... done [08:47:10.917] | : . | : Stopping existing cluster ... [08:47:10.917] | : . | : . No pre-existing cluster. Skipping [08:47:10.917] | : . | : Stopping existing cluster ... done [08:47:10.918] | : . | : Starting new cluster ... [08:47:10.918] | : . | : . makeCluster(workers, ...) ... [08:47:10.918] | : . | : . | Arguments: [08:47:10.918] | : . | : . | List of 2 [08:47:10.918] | : . | : . | $ : int 2 [08:47:10.918] | : . | : . | $ rscript_libs: chr [1:2] "D:/temp/2025_04_10_08_45_16_15127/RtmpUpSTwM/RLIBS_ba78790269fd" "D:/RCompile/recent/R/library" [08:47:11.866] | : . | : . | Generated cluster UUID [08:47:11.866] | : . | : . | Cluster UUID: '44038ef355b6f7df9c62fab9797a2600' [08:47:11.867] | : . | : . | Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R version 4.5.0 RC (2025-04-04 r88126 ucrt), platform x86_64-w64-mingw32) [08:47:11.871] | : . | : . makeCluster(workers, ...) ... done [08:47:11.871] | : . | : . Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R version 4.5.0 RC (2025-04-04 r88126 ucrt), platform x86_64-w64-mingw32) [08:47:11.874] | : . | : Starting new cluster ... done [08:47:11.874] | : . | : Number of workers: 2 [08:47:11.874] | : . | : Workers UUID: '44038ef355b6f7df9c62fab9797a2600' [08:47:11.875] | : . | ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ... done [08:47:11.875] | : . | Backend: <'MultisessionFutureBackend', 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment'> [08:47:11.876] | : . makeFutureBackend() ... done [08:47:11.876] | : plan(): plan_init() of 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... done [08:47:11.876] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:11.877] | : . Getting current ("next") strategy: 'FutureStrategy', 'multisession', 'cluster', 'multiprocess', 'future', 'function' [08:47:11.877] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:11.878] | : plan(): nbrOfWorkers() = 2 [08:47:11.878] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done [08:47:11.878] plan(, .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[08:47:11.890] getGlobalsAndPackages() ... [08:47:11.890] | Searching for globals ... [08:47:11.898] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:11.898] | Searching for globals ... DONE [08:47:11.898] | Resolving globals: FALSE [08:47:11.899] | Search for packages associated with the globals ... [08:47:11.899] | : Packages associated with globals: [2] 'base', 'future' [08:47:11.900] | : Packages: [2] 'base', 'future' [08:47:11.900] | Search for packages associated with the globals ... DONE [08:47:11.901] | Packages after dropping 'base': [1] 'future' [08:47:11.901] | Packages after dropping non-attached packages: [1] 'future' [08:47:11.902] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:11.902] | packages: [1] 'future' [08:47:11.902] getGlobalsAndPackages() ... done 2[08:47:11.911] getGlobalsAndPackages() ... [08:47:11.911] | Searching for globals ... [08:47:11.918] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:11.919] | Searching for globals ... DONE [08:47:11.919] | Resolving globals: FALSE [08:47:11.919] | Search for packages associated with the globals ... [08:47:11.920] | : Packages associated with globals: [2] 'base', 'future' [08:47:11.921] | : Packages: [2] 'base', 'future' [08:47:11.921] | Search for packages associated with the globals ... DONE [08:47:11.921] | Packages after dropping 'base': [1] 'future' [08:47:11.922] | Packages after dropping non-attached packages: [1] 'future' [08:47:11.922] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:11.923] | packages: [1] 'future' [08:47:11.923] getGlobalsAndPackages() ... done 3[08:47:11.924] getGlobalsAndPackages() ... [08:47:11.924] | Searching for globals ... [08:47:11.931] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:11.932] | Searching for globals ... DONE [08:47:11.932] | Resolving globals: FALSE [08:47:11.932] | Search for packages associated with the globals ... [08:47:11.933] | : Packages associated with globals: [2] 'base', 'future' [08:47:11.934] | : Packages: [2] 'base', 'future' [08:47:11.934] | Search for packages associated with the globals ... DONE [08:47:11.934] | Packages after dropping 'base': [1] 'future' [08:47:11.935] | Packages after dropping non-attached packages: [1] 'future' [08:47:11.935] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:11.936] | packages: [1] 'future' [08:47:11.936] getGlobalsAndPackages() ... done 4[08:47:11.937] getGlobalsAndPackages() ... [08:47:11.937] | Searching for globals ... [08:47:11.944] | : globals found: [9] '{', 'message', 'sprintf', 'ii', 'n', '<-', 'mandelbrot', 'C', 'delay' [08:47:11.944] | Searching for globals ... DONE [08:47:11.945] | Resolving globals: FALSE [08:47:11.945] | Search for packages associated with the globals ... [08:47:11.946] | : Packages associated with globals: [2] 'base', 'future' [08:47:11.946] | : Packages: [2] 'base', 'future' [08:47:11.947] | Search for packages associated with the globals ... DONE [08:47:11.947] | Packages after dropping 'base': [1] 'future' [08:47:11.947] | Packages after dropping non-attached packages: [1] 'future' [08:47:11.948] | globals: [4] 'ii', 'n', 'C', 'delay' [08:47:11.948] | packages: [1] 'future' [08:47:11.948] getGlobalsAndPackages() ... done > message(".") . > ## Calculate and plot tiles > repeat { + counts <- plot_what_is_done(counts) + if (!any(sapply(counts, FUN = inherits, "Future"))) break + } [08:47:11.967] resolved() for 'Future' ... [08:47:11.968] | state: 'created' [08:47:11.968] | run: TRUE [08:47:11.968] | run() ... [08:47:11.969] | : run() for Future ('Future') ... [08:47:11.969] | : . state: 'created' [08:47:11.969] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:11.970] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:11.970] | : . Using MultisessionFutureBackend ... [08:47:11.971] | : . | Launching futures ... [08:47:11.971] | : . | : launchFuture() for ClusterFutureBackend ... [08:47:11.972] | : . | : . Workers: [n=2] [08:47:11.972] | : . | : . Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R version 4.5.0 RC (2025-04-04 r88126 ucrt), platform x86_64-w64-mingw32) [08:47:11.975] | : . | : . FutureRegistry: 'workers-44038ef355b6f7df9c62fab9797a2600' [08:47:11.976] | : . | : . requestWorker() ... [08:47:11.976] | : . | : . | requestNode() ... [08:47:11.976] | : . | : . | : Number of workers: 2 [08:47:11.977] | : . | : . | : Polling for a free worker ... [08:47:11.977] | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:11.977] | : . | : . | : . | Created empty registry 'workers-44038ef355b6f7df9c62fab9797a2600' [08:47:11.978] | : . | : . | : . | Listing all futures [08:47:11.978] | : . | : . | : . | Number of registered futures: 0 [08:47:11.978] | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:11.979] | : . | : . | : . Total time: 0 [08:47:11.979] | : . | : . | : Polling for a free worker ... done [08:47:11.979] | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:11.980] | : . | : . | : . Listing all futures [08:47:11.980] | : . | : . | : . Number of registered futures: 0 [08:47:11.980] | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:11.981] | : . | : . | : Index of first available worker: 1 [08:47:11.981] | : . | : . | : Validate that the worker is functional ... [08:47:12.153] | : . | : . | : . Worker is functional [08:47:12.154] | : . | : . | : requestNode() ... done [08:47:12.154] | : . | : . | : cluster node index: 1 [08:47:12.155] | : . | : . | requestWorker() ... done [08:47:12.155] | : . | : . | eraseGlobalEnvironment() ... [08:47:12.156] | : . | : . | eraseGlobalEnvironment() ... done [08:47:12.156] | : . | : . | launchFuture() ... [08:47:12.157] | : . | : . | : cluster node index: 1 [08:47:12.157] | : . | : . | : getFutureData() ... [08:47:12.157] | : . | : . | : . getFutureCore() ... [08:47:12.158] | : . | : . | : . | Packages needed by the future expression (n = 1): 'future' [08:47:12.158] | : . | : . | : . getFutureCore() ... done [08:47:12.158] | : . | : . | : . getFutureCapture() ... [08:47:12.158] | : . | : . | : . getFutureCapture() ... done [08:47:12.159] | : . | : . | : . getFutureContext() ... [08:47:12.159] | : . | : . | : . | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:12.159] | : . | : . | : . | : Getting stack without first strategy: [n=0] [08:47:12.160] | : . | : . | : . | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:12.160] | : . | : . | : . | Packages needed by future strategies (n = 0): [08:47:12.160] | : . | : . | : . getFutureContext() ... done [08:47:12.161] | : . | : . | : getFutureData() ... done [08:47:12.162] | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... [08:47:12.162] | : . | : . | : . Appended future to position #1 [08:47:12.163] | : . | : . | : . Number of registered futures: 1 [08:47:12.163] | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... done [08:47:12.163] | : . | : . | launchFuture() ... done [08:47:12.164] | : . | : . | MultisessionFuture started [08:47:12.164] | : . | : . launchFuture() for ClusterFutureBackend ... done [08:47:12.164] | : . | : Launching futures ... done [08:47:12.164] | : . | : Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future' [08:47:12.165] | : . | Using MultisessionFutureBackend ... done [08:47:12.165] | : . run() for Future ('MultisessionFuture') ... done [08:47:12.165] | : run() ... done [08:47:12.166] | : resolved() ... [08:47:12.166] | : . isFutureResolved() ... [08:47:12.168] | : . | assertValidConnection() ... [08:47:12.168] | : . | : cluster node index: 1 [08:47:12.169] | : . | assertValidConnection() ... done [08:47:12.280] | : . | receiveMessageFromWorker() for ClusterFuture ... [08:47:12.281] | : . | : cluster node index: 1 [08:47:12.281] | : . | : [1] TRUE [08:47:12.282] | : . | : received data: [08:47:12.282] | : . | : List of 5 [08:47:12.282] | : . | : $ type : chr "VALUE" [08:47:12.282] | : . | : $ value :List of 13 [08:47:12.282] | : . | : ..$ value : 'Mandelbrot' int [1:25, 1:25] 1 1 1 1 1 1 1 1 1 1 ... [08:47:12.282] | : . | : .. ..- attr(*, "params")=List of 3 [08:47:12.282] | : . | : .. .. ..$ Z : cplx [1:25, 1:25] -2.25-1.5i -2.25-1.44i -2.25-1.38i ... [08:47:12.282] | : . | : .. .. .. ..- attr(*, "region")=List of 2 [08:47:12.282] | : . | : .. .. .. .. ..$ xrange: num [1:2] -2.25 -0.781 [08:47:12.282] | : . | : .. .. .. .. ..$ yrange: num [1:2] -1.5 -0.0306 [08:47:12.282] | : . | : .. .. .. ..- attr(*, "tile")= int [1:2] 1 1 [08:47:12.282] | : . | : .. .. ..$ maxIter: int 200 [08:47:12.282] | : . | : .. .. ..$ tau : num 2 [08:47:12.282] | : . | : ..$ visible : logi TRUE [08:47:12.282] | : . | : ..$ stdout : chr "" [08:47:12.282] | : . | : ..$ conditions :List of 2 [08:47:12.282] | : . | : .. ..$ :List of 2 [08:47:12.282] | : . | : .. .. ..$ condition:List of 2 [08:47:12.282] | : . | : .. .. .. ..$ message: chr "Calculating tile #1 of 4 ..." [08:47:12.282] | : . | : .. .. .. ..$ call : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE) [08:47:12.282] | : . | : .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69 [08:47:12.282] | : . | : .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.282] | : . | : .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.282] | : . | : .. .. ..$ signaled : int 0 [08:47:12.282] | : . | : .. ..$ :List of 2 [08:47:12.282] | : . | : .. .. ..$ condition:List of 2 [08:47:12.282] | : . | : .. .. .. ..$ message: chr " done\n" [08:47:12.282] | : . | : .. .. .. ..$ call : language message(" done") [08:47:12.282] | : . | : .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75 [08:47:12.282] | : . | : .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.282] | : . | : .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.282] | : . | : .. .. ..$ signaled : int 0 [08:47:12.282] | : . | : ..$ rng : logi FALSE [08:47:12.282] | : . | : ..$ misuseGlobalEnv : NULL [08:47:12.282] | : . | : ..$ misuseConnections:List of 3 [08:47:12.282] | : . | : .. ..$ added : NULL [08:47:12.282] | : . | : .. ..$ removed : NULL [08:47:12.282] | : . | : .. ..$ replaced: NULL [08:47:12.282] | : . | : ..$ misuseDevices : NULL [08:47:12.282] | : . | : ..$ started : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.282] | : . | : ..$ finished : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.282] | : . | : ..$ session_uuid : chr "da40d254b74053c808546c1aec3d714f" [08:47:12.282] | : . | : .. ..- attr(*, "source")=List of 5 [08:47:12.282] | : . | : .. .. ..$ host : Named chr "CRANWIN3" [08:47:12.282] | : . | : .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [08:47:12.282] | : . | : .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [08:47:12.282] | : . | : .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [08:47:12.282] | : . | : .. .. ..$ pid : int 11312 [08:47:12.282] | : . | : .. .. ..$ time : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.282] | : . | : .. .. ..$ random: int 2147483647 [08:47:12.282] | : . | : ..$ r_info :List of 4 [08:47:12.282] | : . | : .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [08:47:12.282] | : . | : .. .. ..$ : int [1:3] 4 5 0 [08:47:12.282] | : . | : .. ..$ os : chr "windows" [08:47:12.282] | : . | : .. ..$ os_name : chr "Windows" [08:47:12.282] | : . | : .. ..$ captures_utf8: logi TRUE [08:47:12.282] | : . | : ..$ version : chr "1.8" [08:47:12.282] | : . | : ..- attr(*, "class")= chr "FutureResult" [08:47:12.282] | : . | : $ success: logi TRUE [08:47:12.282] | : . | : $ time : 'proc_time' Named num [1:5] 0.11 0 0.11 NA NA [08:47:12.282] | : . | : ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [08:47:12.282] | : . | : $ tag : NULL [08:47:12.321] | : . | : Received FutureResult [08:47:12.321] | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... [08:47:12.326] | : . | : . Removed future from position #1 [08:47:12.326] | : . | : . Number of registered futures: 0 [08:47:12.326] | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... done [08:47:12.326] | : . | : Erased future from future backend [08:47:12.327] | : . | : result() for ClusterFuture ... [08:47:12.327] | : . | : . result already collected: FutureResult [08:47:12.328] | : . | : result() for ClusterFuture ... done [08:47:12.328] | : . | : signalConditions() ... [08:47:12.328] | : . | : . include = 'immediateCondition' [08:47:12.328] | : . | : . exclude = [08:47:12.329] | : . | : . resignal = FALSE [08:47:12.329] | : . | : . Number of conditions: 2 [08:47:12.329] | : . | : signalConditions() ... done [08:47:12.330] | : . | receiveMessageFromWorker() for ClusterFuture ... done [08:47:12.330] | : . isFutureResolved() ... done [08:47:12.330] | : . resolved: TRUE [08:47:12.330] | : resolved() ... done [08:47:12.331] | resolved() for 'MultisessionFuture' ... done Plotting tile #1 of 4 ... [08:47:12.331] | result() for ClusterFuture ... [08:47:12.331] | : result already collected: FutureResult [08:47:12.332] | result() for ClusterFuture ... done [08:47:12.332] | result() for ClusterFuture ... [08:47:12.332] | : result already collected: FutureResult [08:47:12.333] | result() for ClusterFuture ... done [08:47:12.333] | signalConditions() ... [08:47:12.333] | : include = 'immediateCondition' [08:47:12.333] | : exclude = [08:47:12.334] | : resignal = FALSE [08:47:12.334] | : Number of conditions: 2 [08:47:12.334] | signalConditions() ... done [08:47:12.335] | Future state: 'finished' [08:47:12.335] | result() for ClusterFuture ... [08:47:12.335] | : result already collected: FutureResult [08:47:12.335] | result() for ClusterFuture ... done [08:47:12.336] | signalConditions() ... [08:47:12.336] | : include = 'condition' [08:47:12.336] | : exclude = 'immediateCondition' [08:47:12.336] | : resignal = TRUE [08:47:12.337] | : Number of conditions: 2 [08:47:12.337] | : Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #1 of 4 ...[08:47:12.337] | : Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:12.338] | signalConditions() ... done [08:47:12.339] | resolved() for 'Future' ... [08:47:12.339] | : state: 'created' [08:47:12.340] | : run: TRUE [08:47:12.340] | : run() ... [08:47:12.340] | : . run() for Future ('Future') ... [08:47:12.340] | : . | state: 'created' [08:47:12.341] | : . | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:12.341] | : . | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:12.341] | : . | Using MultisessionFutureBackend ... [08:47:12.342] | : . | : Launching futures ... [08:47:12.342] | : . | : . launchFuture() for ClusterFutureBackend ... [08:47:12.342] | : . | : . | Workers: [n=2] [08:47:12.343] | : . | : . | Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R version 4.5.0 RC (2025-04-04 r88126 ucrt), platform x86_64-w64-mingw32) [08:47:12.346] | : . | : . | FutureRegistry: 'workers-44038ef355b6f7df9c62fab9797a2600' [08:47:12.346] | : . | : . | requestWorker() ... [08:47:12.346] | : . | : . | : requestNode() ... [08:47:12.347] | : . | : . | : . Number of workers: 2 [08:47:12.347] | : . | : . | : . Polling for a free worker ... [08:47:12.347] | : . | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:12.347] | : . | : . | : . | : Listing all futures [08:47:12.348] | : . | : . | : . | : Number of registered futures: 0 [08:47:12.348] | : . | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:12.348] | : . | : . | : . | Total time: 0 [08:47:12.348] | : . | : . | : . Polling for a free worker ... done [08:47:12.349] | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:12.349] | : . | : . | : . | Listing all futures [08:47:12.349] | : . | : . | : . | Number of registered futures: 0 [08:47:12.349] | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:12.350] | : . | : . | : . Index of first available worker: 1 [08:47:12.350] | : . | : . | : . Validate that the worker is functional ... [08:47:12.402] | : . | : . | : . | Worker is functional [08:47:12.402] | : . | : . | : . requestNode() ... done [08:47:12.403] | : . | : . | : . cluster node index: 1 [08:47:12.403] | : . | : . | : requestWorker() ... done [08:47:12.403] | : . | : . | : eraseGlobalEnvironment() ... [08:47:12.404] | : . | : . | : eraseGlobalEnvironment() ... done [08:47:12.404] | : . | : . | : launchFuture() ... [08:47:12.405] | : . | : . | : . cluster node index: 1 [08:47:12.405] | : . | : . | : . getFutureData() ... [08:47:12.405] | : . | : . | : . | getFutureCore() ... [08:47:12.406] | : . | : . | : . | : Packages needed by the future expression (n = 1): 'future' [08:47:12.406] | : . | : . | : . | getFutureCore() ... done [08:47:12.406] | : . | : . | : . | getFutureCapture() ... [08:47:12.406] | : . | : . | : . | getFutureCapture() ... done [08:47:12.407] | : . | : . | : . | getFutureContext() ... [08:47:12.407] | : . | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:12.407] | : . | : . | : . | : . Getting stack without first strategy: [n=0] [08:47:12.408] | : . | : . | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:12.408] | : . | : . | : . | : Packages needed by future strategies (n = 0): [08:47:12.408] | : . | : . | : . | getFutureContext() ... done [08:47:12.409] | : . | : . | : . getFutureData() ... done [08:47:12.409] | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... [08:47:12.410] | : . | : . | : . | Appended future to position #1 [08:47:12.410] | : . | : . | : . | Number of registered futures: 1 [08:47:12.410] | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... done [08:47:12.411] | : . | : . | : launchFuture() ... done [08:47:12.411] | : . | : . | : MultisessionFuture started [08:47:12.411] | : . | : . | launchFuture() for ClusterFutureBackend ... done [08:47:12.411] | : . | : . Launching futures ... done [08:47:12.412] | : . | : . Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future' [08:47:12.412] | : . | : Using MultisessionFutureBackend ... done [08:47:12.412] | : . | run() for Future ('MultisessionFuture') ... done [08:47:12.413] | : . run() ... done [08:47:12.413] | : . resolved() ... [08:47:12.413] | : . | isFutureResolved() ... [08:47:12.414] | : . | : assertValidConnection() ... [08:47:12.414] | : . | : . cluster node index: 1 [08:47:12.415] | : . | : assertValidConnection() ... done [08:47:12.424] | : . | : receiveMessageFromWorker() for ClusterFuture ... [08:47:12.425] | : . | : . cluster node index: 1 [08:47:12.426] | : . | : . [1] TRUE [08:47:12.426] | : . | : . received data: [08:47:12.426] | : . | : . List of 5 [08:47:12.426] | : . | : . $ type : chr "VALUE" [08:47:12.426] | : . | : . $ value :List of 13 [08:47:12.426] | : . | : . ..$ value : 'Mandelbrot' int [1:25, 1:25] 1 1 1 1 2 2 2 2 2 3 ... [08:47:12.426] | : . | : . .. ..- attr(*, "params")=List of 3 [08:47:12.426] | : . | : . .. .. ..$ Z : cplx [1:25, 1:25] -0.719-1.5i -0.719-1.44i -0.719-1.38i ... [08:47:12.426] | : . | : . .. .. .. ..- attr(*, "region")=List of 2 [08:47:12.426] | : . | : . .. .. .. .. ..$ xrange: num [1:2] -0.719 0.75 [08:47:12.426] | : . | : . .. .. .. .. ..$ yrange: num [1:2] -1.5 -0.0306 [08:47:12.426] | : . | : . .. .. .. ..- attr(*, "tile")= int [1:2] 1 2 [08:47:12.426] | : . | : . .. .. ..$ maxIter: int 200 [08:47:12.426] | : . | : . .. .. ..$ tau : num 2 [08:47:12.426] | : . | : . ..$ visible : logi TRUE [08:47:12.426] | : . | : . ..$ stdout : chr "" [08:47:12.426] | : . | : . ..$ conditions :List of 2 [08:47:12.426] | : . | : . .. ..$ :List of 2 [08:47:12.426] | : . | : . .. .. ..$ condition:List of 2 [08:47:12.426] | : . | : . .. .. .. ..$ message: chr "Calculating tile #2 of 4 ..." [08:47:12.426] | : . | : . .. .. .. ..$ call : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE) [08:47:12.426] | : . | : . .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69 [08:47:12.426] | : . | : . .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.426] | : . | : . .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.426] | : . | : . .. .. ..$ signaled : int 0 [08:47:12.426] | : . | : . .. ..$ :List of 2 [08:47:12.426] | : . | : . .. .. ..$ condition:List of 2 [08:47:12.426] | : . | : . .. .. .. ..$ message: chr " done\n" [08:47:12.426] | : . | : . .. .. .. ..$ call : language message(" done") [08:47:12.426] | : . | : . .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75 [08:47:12.426] | : . | : . .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.426] | : . | : . .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.426] | : . | : . .. .. ..$ signaled : int 0 [08:47:12.426] | : . | : . ..$ rng : logi FALSE [08:47:12.426] | : . | : . ..$ misuseGlobalEnv : NULL [08:47:12.426] | : . | : . ..$ misuseConnections:List of 3 [08:47:12.426] | : . | : . .. ..$ added : NULL [08:47:12.426] | : . | : . .. ..$ removed : NULL [08:47:12.426] | : . | : . .. ..$ replaced: NULL [08:47:12.426] | : . | : . ..$ misuseDevices : NULL [08:47:12.426] | : . | : . ..$ started : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.426] | : . | : . ..$ finished : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.426] | : . | : . ..$ session_uuid : chr "da40d254b74053c808546c1aec3d714f" [08:47:12.426] | : . | : . .. ..- attr(*, "source")=List of 5 [08:47:12.426] | : . | : . .. .. ..$ host : Named chr "CRANWIN3" [08:47:12.426] | : . | : . .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [08:47:12.426] | : . | : . .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [08:47:12.426] | : . | : . .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [08:47:12.426] | : . | : . .. .. ..$ pid : int 11312 [08:47:12.426] | : . | : . .. .. ..$ time : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.426] | : . | : . .. .. ..$ random: int 2147483647 [08:47:12.426] | : . | : . ..$ r_info :List of 4 [08:47:12.426] | : . | : . .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [08:47:12.426] | : . | : . .. .. ..$ : int [1:3] 4 5 0 [08:47:12.426] | : . | : . .. ..$ os : chr "windows" [08:47:12.426] | : . | : . .. ..$ os_name : chr "Windows" [08:47:12.426] | : . | : . .. ..$ captures_utf8: logi TRUE [08:47:12.426] | : . | : . ..$ version : chr "1.8" [08:47:12.426] | : . | : . ..- attr(*, "class")= chr "FutureResult" [08:47:12.426] | : . | : . $ success: logi TRUE [08:47:12.426] | : . | : . $ time : 'proc_time' Named num [1:5] 0.01 0 0.01 NA NA [08:47:12.426] | : . | : . ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [08:47:12.426] | : . | : . $ tag : NULL [08:47:12.459] | : . | : . Received FutureResult [08:47:12.459] | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... [08:47:12.459] | : . | : . | Removed future from position #1 [08:47:12.459] | : . | : . | Number of registered futures: 0 [08:47:12.460] | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... done [08:47:12.460] | : . | : . Erased future from future backend [08:47:12.460] | : . | : . result() for ClusterFuture ... [08:47:12.461] | : . | : . | result already collected: FutureResult [08:47:12.461] | : . | : . result() for ClusterFuture ... done [08:47:12.461] | : . | : . signalConditions() ... [08:47:12.461] | : . | : . | include = 'immediateCondition' [08:47:12.462] | : . | : . | exclude = [08:47:12.462] | : . | : . | resignal = FALSE [08:47:12.462] | : . | : . | Number of conditions: 2 [08:47:12.463] | : . | : . signalConditions() ... done [08:47:12.463] | : . | : receiveMessageFromWorker() for ClusterFuture ... done [08:47:12.463] | : . | isFutureResolved() ... done [08:47:12.463] | : . | resolved: TRUE [08:47:12.464] | : . resolved() ... done [08:47:12.464] | : resolved() for 'MultisessionFuture' ... done Plotting tile #2 of 4 ... [08:47:12.464] | : result() for ClusterFuture ... [08:47:12.465] | : . result already collected: FutureResult [08:47:12.465] | : result() for ClusterFuture ... done [08:47:12.465] | : result() for ClusterFuture ... [08:47:12.466] | : . result already collected: FutureResult [08:47:12.466] | : result() for ClusterFuture ... done [08:47:12.466] | : signalConditions() ... [08:47:12.466] | : . include = 'immediateCondition' [08:47:12.467] | : . exclude = [08:47:12.467] | : . resignal = FALSE [08:47:12.467] | : . Number of conditions: 2 [08:47:12.468] | : signalConditions() ... done [08:47:12.468] | : Future state: 'finished' [08:47:12.468] | : result() for ClusterFuture ... [08:47:12.468] | : . result already collected: FutureResult [08:47:12.469] | : result() for ClusterFuture ... done [08:47:12.469] | : signalConditions() ... [08:47:12.469] | : . include = 'condition' [08:47:12.470] | : . exclude = 'immediateCondition' [08:47:12.470] | : . resignal = TRUE [08:47:12.470] | : . Number of conditions: 2 [08:47:12.471] | : . Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #2 of 4 ...[08:47:12.471] | : . Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:12.471] | : signalConditions() ... done [08:47:12.473] | : resolved() for 'Future' ... [08:47:12.473] | : . state: 'created' [08:47:12.473] | : . run: TRUE [08:47:12.474] | : . run() ... [08:47:12.474] | : . | run() for Future ('Future') ... [08:47:12.474] | : . | : state: 'created' [08:47:12.474] | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:12.475] | : . | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:12.475] | : . | : Using MultisessionFutureBackend ... [08:47:12.475] | : . | : . Launching futures ... [08:47:12.476] | : . | : . | launchFuture() for ClusterFutureBackend ... [08:47:12.476] | : . | : . | : Workers: [n=2] [08:47:12.476] | : . | : . | : Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R version 4.5.0 RC (2025-04-04 r88126 ucrt), platform x86_64-w64-mingw32) [08:47:12.480] | : . | : . | : FutureRegistry: 'workers-44038ef355b6f7df9c62fab9797a2600' [08:47:12.480] | : . | : . | : requestWorker() ... [08:47:12.480] | : . | : . | : . requestNode() ... [08:47:12.480] | : . | : . | : . | Number of workers: 2 [08:47:12.481] | : . | : . | : . | Polling for a free worker ... [08:47:12.481] | : . | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:12.481] | : . | : . | : . | : . Listing all futures [08:47:12.482] | : . | : . | : . | : . Number of registered futures: 0 [08:47:12.482] | : . | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:12.482] | : . | : . | : . | : Total time: 0 [08:47:12.482] | : . | : . | : . | Polling for a free worker ... done [08:47:12.483] | : . | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:12.483] | : . | : . | : . | : Listing all futures [08:47:12.483] | : . | : . | : . | : Number of registered futures: 0 [08:47:12.484] | : . | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:12.484] | : . | : . | : . | Index of first available worker: 1 [08:47:12.484] | : . | : . | : . | Validate that the worker is functional ... [08:47:12.545] | : . | : . | : . | : Worker is functional [08:47:12.546] | : . | : . | : . | requestNode() ... done [08:47:12.546] | : . | : . | : . | cluster node index: 1 [08:47:12.546] | : . | : . | : . requestWorker() ... done [08:47:12.546] | : . | : . | : . eraseGlobalEnvironment() ... [08:47:12.547] | : . | : . | : . eraseGlobalEnvironment() ... done [08:47:12.547] | : . | : . | : . launchFuture() ... [08:47:12.547] | : . | : . | : . | cluster node index: 1 [08:47:12.548] | : . | : . | : . | getFutureData() ... [08:47:12.548] | : . | : . | : . | : getFutureCore() ... [08:47:12.548] | : . | : . | : . | : . Packages needed by the future expression (n = 1): 'future' [08:47:12.548] | : . | : . | : . | : getFutureCore() ... done [08:47:12.548] | : . | : . | : . | : getFutureCapture() ... [08:47:12.549] | : . | : . | : . | : getFutureCapture() ... done [08:47:12.549] | : . | : . | : . | : getFutureContext() ... [08:47:12.549] | : . | : . | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:12.549] | : . | : . | : . | : . | Getting stack without first strategy: [n=0] [08:47:12.549] | : . | : . | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:12.549] | : . | : . | : . | : . Packages needed by future strategies (n = 0): [08:47:12.550] | : . | : . | : . | : getFutureContext() ... done [08:47:12.550] | : . | : . | : . | getFutureData() ... done [08:47:12.550] | : . | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... [08:47:12.551] | : . | : . | : . | : Appended future to position #1 [08:47:12.551] | : . | : . | : . | : Number of registered futures: 1 [08:47:12.551] | : . | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... done [08:47:12.551] | : . | : . | : . launchFuture() ... done [08:47:12.551] | : . | : . | : . MultisessionFuture started [08:47:12.551] | : . | : . | : launchFuture() for ClusterFutureBackend ... done [08:47:12.551] | : . | : . | Launching futures ... done [08:47:12.552] | : . | : . | Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future' [08:47:12.552] | : . | : . Using MultisessionFutureBackend ... done [08:47:12.552] | : . | : run() for Future ('MultisessionFuture') ... done [08:47:12.552] | : . | run() ... done [08:47:12.552] | : . | resolved() ... [08:47:12.552] | : . | : isFutureResolved() ... [08:47:12.553] | : . | : . assertValidConnection() ... [08:47:12.553] | : . | : . | cluster node index: 1 [08:47:12.553] | : . | : . assertValidConnection() ... done [08:47:12.558] | : . | : . receiveMessageFromWorker() for ClusterFuture ... [08:47:12.558] | : . | : . | cluster node index: 1 [08:47:12.559] | : . | : . | [1] TRUE [08:47:12.560] | : . | : . | received data: [08:47:12.560] | : . | : . | List of 5 [08:47:12.560] | : . | : . | $ type : chr "VALUE" [08:47:12.560] | : . | : . | $ value :List of 13 [08:47:12.560] | : . | : . | ..$ value : 'Mandelbrot' int [1:25, 1:25] 1 1 1 1 1 1 1 1 1 1 ... [08:47:12.560] | : . | : . | .. ..- attr(*, "params")=List of 3 [08:47:12.560] | : . | : . | .. .. ..$ Z : cplx [1:25, 1:25] -2.25+0.0306i -2.25+0.0918i -2.25+0.1531i ... [08:47:12.560] | : . | : . | .. .. .. ..- attr(*, "region")=List of 2 [08:47:12.560] | : . | : . | .. .. .. .. ..$ xrange: num [1:2] -2.25 -0.781 [08:47:12.560] | : . | : . | .. .. .. .. ..$ yrange: num [1:2] 0.0306 1.5 [08:47:12.560] | : . | : . | .. .. .. ..- attr(*, "tile")= int [1:2] 2 1 [08:47:12.560] | : . | : . | .. .. ..$ maxIter: int 200 [08:47:12.560] | : . | : . | .. .. ..$ tau : num 2 [08:47:12.560] | : . | : . | ..$ visible : logi TRUE [08:47:12.560] | : . | : . | ..$ stdout : chr "" [08:47:12.560] | : . | : . | ..$ conditions :List of 2 [08:47:12.560] | : . | : . | .. ..$ :List of 2 [08:47:12.560] | : . | : . | .. .. ..$ condition:List of 2 [08:47:12.560] | : . | : . | .. .. .. ..$ message: chr "Calculating tile #3 of 4 ..." [08:47:12.560] | : . | : . | .. .. .. ..$ call : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE) [08:47:12.560] | : . | : . | .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69 [08:47:12.560] | : . | : . | .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.560] | : . | : . | .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.560] | : . | : . | .. .. ..$ signaled : int 0 [08:47:12.560] | : . | : . | .. ..$ :List of 2 [08:47:12.560] | : . | : . | .. .. ..$ condition:List of 2 [08:47:12.560] | : . | : . | .. .. .. ..$ message: chr " done\n" [08:47:12.560] | : . | : . | .. .. .. ..$ call : language message(" done") [08:47:12.560] | : . | : . | .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75 [08:47:12.560] | : . | : . | .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.560] | : . | : . | .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.560] | : . | : . | .. .. ..$ signaled : int 0 [08:47:12.560] | : . | : . | ..$ rng : logi FALSE [08:47:12.560] | : . | : . | ..$ misuseGlobalEnv : NULL [08:47:12.560] | : . | : . | ..$ misuseConnections:List of 3 [08:47:12.560] | : . | : . | .. ..$ added : NULL [08:47:12.560] | : . | : . | .. ..$ removed : NULL [08:47:12.560] | : . | : . | .. ..$ replaced: NULL [08:47:12.560] | : . | : . | ..$ misuseDevices : NULL [08:47:12.560] | : . | : . | ..$ started : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.560] | : . | : . | ..$ finished : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.560] | : . | : . | ..$ session_uuid : chr "da40d254b74053c808546c1aec3d714f" [08:47:12.560] | : . | : . | .. ..- attr(*, "source")=List of 5 [08:47:12.560] | : . | : . | .. .. ..$ host : Named chr "CRANWIN3" [08:47:12.560] | : . | : . | .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [08:47:12.560] | : . | : . | .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [08:47:12.560] | : . | : . | .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [08:47:12.560] | : . | : . | .. .. ..$ pid : int 11312 [08:47:12.560] | : . | : . | .. .. ..$ time : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.560] | : . | : . | .. .. ..$ random: int 2147483647 [08:47:12.560] | : . | : . | ..$ r_info :List of 4 [08:47:12.560] | : . | : . | .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [08:47:12.560] | : . | : . | .. .. ..$ : int [1:3] 4 5 0 [08:47:12.560] | : . | : . | .. ..$ os : chr "windows" [08:47:12.560] | : . | : . | .. ..$ os_name : chr "Windows" [08:47:12.560] | : . | : . | .. ..$ captures_utf8: logi TRUE [08:47:12.560] | : . | : . | ..$ version : chr "1.8" [08:47:12.560] | : . | : . | ..- attr(*, "class")= chr "FutureResult" [08:47:12.560] | : . | : . | $ success: logi TRUE [08:47:12.560] | : . | : . | $ time : 'proc_time' Named num [1:5] 0 0 0 NA NA [08:47:12.560] | : . | : . | ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [08:47:12.560] | : . | : . | $ tag : NULL [08:47:12.592] | : . | : . | Received FutureResult [08:47:12.592] | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... [08:47:12.592] | : . | : . | : Removed future from position #1 [08:47:12.593] | : . | : . | : Number of registered futures: 0 [08:47:12.593] | : . | : . | FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... done [08:47:12.593] | : . | : . | Erased future from future backend [08:47:12.593] | : . | : . | result() for ClusterFuture ... [08:47:12.594] | : . | : . | : result already collected: FutureResult [08:47:12.594] | : . | : . | result() for ClusterFuture ... done [08:47:12.594] | : . | : . | signalConditions() ... [08:47:12.594] | : . | : . | : include = 'immediateCondition' [08:47:12.595] | : . | : . | : exclude = [08:47:12.595] | : . | : . | : resignal = FALSE [08:47:12.595] | : . | : . | : Number of conditions: 2 [08:47:12.596] | : . | : . | signalConditions() ... done [08:47:12.596] | : . | : . receiveMessageFromWorker() for ClusterFuture ... done [08:47:12.596] | : . | : isFutureResolved() ... done [08:47:12.596] | : . | : resolved: TRUE [08:47:12.597] | : . | resolved() ... done [08:47:12.597] | : . resolved() for 'MultisessionFuture' ... done Plotting tile #3 of 4 ... [08:47:12.597] | : . result() for ClusterFuture ... [08:47:12.597] | : . | result already collected: FutureResult [08:47:12.598] | : . result() for ClusterFuture ... done [08:47:12.598] | : . result() for ClusterFuture ... [08:47:12.598] | : . | result already collected: FutureResult [08:47:12.598] | : . result() for ClusterFuture ... done [08:47:12.599] | : . signalConditions() ... [08:47:12.599] | : . | include = 'immediateCondition' [08:47:12.599] | : . | exclude = [08:47:12.599] | : . | resignal = FALSE [08:47:12.600] | : . | Number of conditions: 2 [08:47:12.600] | : . signalConditions() ... done [08:47:12.600] | : . Future state: 'finished' [08:47:12.601] | : . result() for ClusterFuture ... [08:47:12.601] | : . | result already collected: FutureResult [08:47:12.601] | : . result() for ClusterFuture ... done [08:47:12.601] | : . signalConditions() ... [08:47:12.601] | : . | include = 'condition' [08:47:12.602] | : . | exclude = 'immediateCondition' [08:47:12.602] | : . | resignal = TRUE [08:47:12.602] | : . | Number of conditions: 2 [08:47:12.602] | : . | Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #3 of 4 ...[08:47:12.603] | : . | Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:12.603] | : . signalConditions() ... done [08:47:12.604] | : . resolved() for 'Future' ... [08:47:12.604] | : . | state: 'created' [08:47:12.605] | : . | run: TRUE [08:47:12.605] | : . | run() ... [08:47:12.605] | : . | : run() for Future ('Future') ... [08:47:12.605] | : . | : . state: 'created' [08:47:12.606] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:12.606] | : . | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:12.606] | : . | : . Using MultisessionFutureBackend ... [08:47:12.606] | : . | : . | Launching futures ... [08:47:12.607] | : . | : . | : launchFuture() for ClusterFutureBackend ... [08:47:12.607] | : . | : . | : . Workers: [n=2] [08:47:12.607] | : . | : . | : . Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R version 4.5.0 RC (2025-04-04 r88126 ucrt), platform x86_64-w64-mingw32) [08:47:12.610] | : . | : . | : . FutureRegistry: 'workers-44038ef355b6f7df9c62fab9797a2600' [08:47:12.610] | : . | : . | : . requestWorker() ... [08:47:12.610] | : . | : . | : . | requestNode() ... [08:47:12.610] | : . | : . | : . | : Number of workers: 2 [08:47:12.610] | : . | : . | : . | : Polling for a free worker ... [08:47:12.610] | : . | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:12.611] | : . | : . | : . | : . | Listing all futures [08:47:12.611] | : . | : . | : . | : . | Number of registered futures: 0 [08:47:12.611] | : . | : . | : . | : . FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:12.611] | : . | : . | : . | : . Total time: 0 [08:47:12.611] | : . | : . | : . | : Polling for a free worker ... done [08:47:12.611] | : . | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... [08:47:12.612] | : . | : . | : . | : . Listing all futures [08:47:12.612] | : . | : . | : . | : . Number of registered futures: 0 [08:47:12.612] | : . | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'list', earlySignal = 0) ... done [08:47:12.612] | : . | : . | : . | : Index of first available worker: 1 [08:47:12.612] | : . | : . | : . | : Validate that the worker is functional ... [08:47:12.660] | : . | : . | : . | : . Worker is functional [08:47:12.661] | : . | : . | : . | : requestNode() ... done [08:47:12.661] | : . | : . | : . | : cluster node index: 1 [08:47:12.661] | : . | : . | : . | requestWorker() ... done [08:47:12.661] | : . | : . | : . | eraseGlobalEnvironment() ... [08:47:12.662] | : . | : . | : . | eraseGlobalEnvironment() ... done [08:47:12.662] | : . | : . | : . | launchFuture() ... [08:47:12.663] | : . | : . | : . | : cluster node index: 1 [08:47:12.663] | : . | : . | : . | : getFutureData() ... [08:47:12.663] | : . | : . | : . | : . getFutureCore() ... [08:47:12.663] | : . | : . | : . | : . | Packages needed by the future expression (n = 1): 'future' [08:47:12.664] | : . | : . | : . | : . getFutureCore() ... done [08:47:12.664] | : . | : . | : . | : . getFutureCapture() ... [08:47:12.664] | : . | : . | : . | : . getFutureCapture() ... done [08:47:12.664] | : . | : . | : . | : . getFutureContext() ... [08:47:12.664] | : . | : . | : . | : . | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [08:47:12.665] | : . | : . | : . | : . | : Getting stack without first strategy: [n=0] [08:47:12.665] | : . | : . | : . | : . | plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [08:47:12.665] | : . | : . | : . | : . | Packages needed by future strategies (n = 0): [08:47:12.665] | : . | : . | : . | : . getFutureContext() ... done [08:47:12.665] | : . | : . | : . | : getFutureData() ... done [08:47:12.666] | : . | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... [08:47:12.667] | : . | : . | : . | : . Appended future to position #1 [08:47:12.667] | : . | : . | : . | : . Number of registered futures: 1 [08:47:12.667] | : . | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'add', earlySignal = 0) ... done [08:47:12.667] | : . | : . | : . | launchFuture() ... done [08:47:12.668] | : . | : . | : . | MultisessionFuture started [08:47:12.668] | : . | : . | : . launchFuture() for ClusterFutureBackend ... done [08:47:12.668] | : . | : . | : Launching futures ... done [08:47:12.668] | : . | : . | : Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future' [08:47:12.669] | : . | : . | Using MultisessionFutureBackend ... done [08:47:12.669] | : . | : . run() for Future ('MultisessionFuture') ... done [08:47:12.669] | : . | : run() ... done [08:47:12.669] | : . | : resolved() ... [08:47:12.670] | : . | : . isFutureResolved() ... [08:47:12.670] | : . | : . | assertValidConnection() ... [08:47:12.671] | : . | : . | : cluster node index: 1 [08:47:12.671] | : . | : . | assertValidConnection() ... done [08:47:12.677] | : . | : . | receiveMessageFromWorker() for ClusterFuture ... [08:47:12.678] | : . | : . | : cluster node index: 1 [08:47:12.679] | : . | : . | : [1] TRUE [08:47:12.679] | : . | : . | : received data: [08:47:12.680] | : . | : . | : List of 5 [08:47:12.680] | : . | : . | : $ type : chr "VALUE" [08:47:12.680] | : . | : . | : $ value :List of 13 [08:47:12.680] | : . | : . | : ..$ value : 'Mandelbrot' int [1:25, 1:25] 200 200 200 109 195 15 9 8 5 5 ... [08:47:12.680] | : . | : . | : .. ..- attr(*, "params")=List of 3 [08:47:12.680] | : . | : . | : .. .. ..$ Z : cplx [1:25, 1:25] -0.719+0.0306i -0.719+0.0918i -0.719+0.1531i ... [08:47:12.680] | : . | : . | : .. .. .. ..- attr(*, "region")=List of 2 [08:47:12.680] | : . | : . | : .. .. .. .. ..$ xrange: num [1:2] -0.719 0.75 [08:47:12.680] | : . | : . | : .. .. .. .. ..$ yrange: num [1:2] 0.0306 1.5 [08:47:12.680] | : . | : . | : .. .. .. ..- attr(*, "tile")= int [1:2] 2 2 [08:47:12.680] | : . | : . | : .. .. ..$ maxIter: int 200 [08:47:12.680] | : . | : . | : .. .. ..$ tau : num 2 [08:47:12.680] | : . | : . | : ..$ visible : logi TRUE [08:47:12.680] | : . | : . | : ..$ stdout : chr "" [08:47:12.680] | : . | : . | : ..$ conditions :List of 2 [08:47:12.680] | : . | : . | : .. ..$ :List of 2 [08:47:12.680] | : . | : . | : .. .. ..$ condition:List of 2 [08:47:12.680] | : . | : . | : .. .. .. ..$ message: chr "Calculating tile #4 of 4 ..." [08:47:12.680] | : . | : . | : .. .. .. ..$ call : language message(sprintf("Calculating tile #%d of %d ...", ii, n), appendLF = FALSE) [08:47:12.680] | : . | : . | : .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 69 5 69 79 5 79 69 69 [08:47:12.680] | : . | : . | : .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.680] | : . | : . | : .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.680] | : . | : . | : .. .. ..$ signaled : int 0 [08:47:12.680] | : . | : . | : .. ..$ :List of 2 [08:47:12.680] | : . | : . | : .. .. ..$ condition:List of 2 [08:47:12.680] | : . | : . | : .. .. .. ..$ message: chr " done\n" [08:47:12.680] | : . | : . | : .. .. .. ..$ call : language message(" done") [08:47:12.680] | : . | : . | : .. .. .. .. ..- attr(*, "srcref")= 'srcref' int [1:8] 75 5 75 20 5 20 75 75 [08:47:12.680] | : . | : . | : .. .. .. .. .. ..- attr(*, "srcfile")=Classes 'srcfilecopy', 'srcfile' [08:47:12.680] | : . | : . | : .. .. .. ..- attr(*, "class")= chr [1:3] "simpleMessage" "message" "condition" [08:47:12.680] | : . | : . | : .. .. ..$ signaled : int 0 [08:47:12.680] | : . | : . | : ..$ rng : logi FALSE [08:47:12.680] | : . | : . | : ..$ misuseGlobalEnv : NULL [08:47:12.680] | : . | : . | : ..$ misuseConnections:List of 3 [08:47:12.680] | : . | : . | : .. ..$ added : NULL [08:47:12.680] | : . | : . | : .. ..$ removed : NULL [08:47:12.680] | : . | : . | : .. ..$ replaced: NULL [08:47:12.680] | : . | : . | : ..$ misuseDevices : NULL [08:47:12.680] | : . | : . | : ..$ started : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.680] | : . | : . | : ..$ finished : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.680] | : . | : . | : ..$ session_uuid : chr "da40d254b74053c808546c1aec3d714f" [08:47:12.680] | : . | : . | : .. ..- attr(*, "source")=List of 5 [08:47:12.680] | : . | : . | : .. .. ..$ host : Named chr "CRANWIN3" [08:47:12.680] | : . | : . | : .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [08:47:12.680] | : . | : . | : .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [08:47:12.680] | : . | : . | : .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [08:47:12.680] | : . | : . | : .. .. ..$ pid : int 11312 [08:47:12.680] | : . | : . | : .. .. ..$ time : POSIXct[1:1], format: "2025-04-10 08:47:12" [08:47:12.680] | : . | : . | : .. .. ..$ random: int 2147483647 [08:47:12.680] | : . | : . | : ..$ r_info :List of 4 [08:47:12.680] | : . | : . | : .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [08:47:12.680] | : . | : . | : .. .. ..$ : int [1:3] 4 5 0 [08:47:12.680] | : . | : . | : .. ..$ os : chr "windows" [08:47:12.680] | : . | : . | : .. ..$ os_name : chr "Windows" [08:47:12.680] | : . | : . | : .. ..$ captures_utf8: logi TRUE [08:47:12.680] | : . | : . | : ..$ version : chr "1.8" [08:47:12.680] | : . | : . | : ..- attr(*, "class")= chr "FutureResult" [08:47:12.680] | : . | : . | : $ success: logi TRUE [08:47:12.680] | : . | : . | : $ time : 'proc_time' Named num [1:5] 0.02 0 0.01 NA NA [08:47:12.680] | : . | : . | : ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [08:47:12.680] | : . | : . | : $ tag : NULL [08:47:12.717] | : . | : . | : Received FutureResult [08:47:12.718] | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... [08:47:12.718] | : . | : . | : . Removed future from position #1 [08:47:12.718] | : . | : . | : . Number of registered futures: 0 [08:47:12.719] | : . | : . | : FutureRegistry('workers-44038ef355b6f7df9c62fab9797a2600', action = 'remove', earlySignal = 0) ... done [08:47:12.719] | : . | : . | : Erased future from future backend [08:47:12.719] | : . | : . | : result() for ClusterFuture ... [08:47:12.720] | : . | : . | : . result already collected: FutureResult [08:47:12.720] | : . | : . | : result() for ClusterFuture ... done [08:47:12.720] | : . | : . | : signalConditions() ... [08:47:12.721] | : . | : . | : . include = 'immediateCondition' [08:47:12.721] | : . | : . | : . exclude = [08:47:12.721] | : . | : . | : . resignal = FALSE [08:47:12.722] | : . | : . | : . Number of conditions: 2 [08:47:12.722] | : . | : . | : signalConditions() ... done [08:47:12.722] | : . | : . | receiveMessageFromWorker() for ClusterFuture ... done [08:47:12.723] | : . | : . isFutureResolved() ... done [08:47:12.723] | : . | : . resolved: TRUE [08:47:12.723] | : . | : resolved() ... done [08:47:12.724] | : . | resolved() for 'MultisessionFuture' ... done Plotting tile #4 of 4 ... [08:47:12.724] | : . | result() for ClusterFuture ... [08:47:12.724] | : . | : result already collected: FutureResult [08:47:12.725] | : . | result() for ClusterFuture ... done [08:47:12.725] | : . | result() for ClusterFuture ... [08:47:12.725] | : . | : result already collected: FutureResult [08:47:12.726] | : . | result() for ClusterFuture ... done [08:47:12.726] | : . | signalConditions() ... [08:47:12.726] | : . | : include = 'immediateCondition' [08:47:12.727] | : . | : exclude = [08:47:12.727] | : . | : resignal = FALSE [08:47:12.727] | : . | : Number of conditions: 2 [08:47:12.728] | : . | signalConditions() ... done [08:47:12.728] | : . | Future state: 'finished' [08:47:12.728] | : . | result() for ClusterFuture ... [08:47:12.729] | : . | : result already collected: FutureResult [08:47:12.729] | : . | result() for ClusterFuture ... done [08:47:12.729] | : . | signalConditions() ... [08:47:12.730] | : . | : include = 'condition' [08:47:12.730] | : . | : exclude = 'immediateCondition' [08:47:12.730] | : . | : resignal = TRUE [08:47:12.731] | : . | : Number of conditions: 2 [08:47:12.731] | : . | : Condition #1: 'simpleMessage', 'message', 'condition' Calculating tile #4 of 4 ...[08:47:12.731] | : . | : Condition #2: 'simpleMessage', 'message', 'condition' done [08:47:12.732] | : . | signalConditions() ... 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_04_10_08_45_16_15127' Sourcing 6 epilogue scripts ... done Test time: user.self=2s, sys.self=0.08s, elapsed=3s, user.child=NAs, sys.child=NAs Test 'demo-mandelbrot' ... success > > proc.time() user system elapsed 1.81 0.15 3.04