R Under development (unstable) (2024-07-28 r86931 ucrt) -- "Unsuffered Consequences" Copyright (C) 2024 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. > source("incl/start.R") [17:28:30.690] plan(): Setting new future strategy stack: [17:28:30.693] List of future strategies: [17:28:30.693] 1. sequential: [17:28:30.693] - args: function (..., envir = parent.frame(), workers = "") [17:28:30.693] - tweaked: FALSE [17:28:30.693] - call: future::plan("sequential") [17:28:30.719] plan(): nbrOfWorkers() = 1 > > message("*** nbrOfWorkers() ...") *** nbrOfWorkers() ... > > strategies <- c("sequential") > for (strategy in strategies) { + message("Type of future: ", strategy) + + evaluator <- get(strategy, mode = "function") + n <- nbrOfWorkers(evaluator) + message(sprintf("nbrOfWorkers: %d", n)) + stopifnot(n == 1L) + + plan(strategy) + n <- nbrOfWorkers() + message(sprintf("nbrOfWorkers: %d", n)) + stopifnot(n == 1L) + + n <- nbrOfFreeWorkers() + message(sprintf("nbrOfFreeWorkers: %d", n)) + stopifnot(n == 1L) + + n <- nbrOfFreeWorkers(background = TRUE) + message(sprintf("nbrOfFreeWorkers(background = TRUE): %d", n)) + stopifnot(n == 0L) + } ## for (strategy ...) Type of future: sequential nbrOfWorkers: 1 [17:28:30.747] plan(): Setting new future strategy stack: [17:28:30.747] List of future strategies: [17:28:30.747] 1. sequential: [17:28:30.747] - args: function (..., envir = parent.frame(), workers = "") [17:28:30.747] - tweaked: FALSE [17:28:30.747] - call: plan(strategy) [17:28:30.772] plan(): nbrOfWorkers() = 1 nbrOfWorkers: 1 nbrOfFreeWorkers: 1 nbrOfFreeWorkers(background = TRUE): 0 > > > strategies <- c("cluster", "multisession", "multicore") > strategies <- intersect(strategies, supportedStrategies()) > cores <- availableCores() > message("Number of available cores: ", cores) Number of available cores: 2 > workers <- availableWorkers() > nworkers <- length(workers) > message(sprintf("Available workers: [n = %d] %s", nworkers, hpaste(sQuote(workers)))) Available workers: [n = 2] 'localhost', 'localhost' > > allButOneCore <- function() max(1L, future::availableCores() - 1L) > allButOneWorker <- function() { + w <- future::availableWorkers() + if (length(w) > 1) w[-1] else w + } > > for (strategy in strategies) { + ## Speed up CRAN checks: Skip on CRAN Windows 32-bit + if (!fullTest && isWin32) next + + message("Type of future: ", strategy) + + evaluator <- get(strategy, mode = "function") + n <- nbrOfWorkers(evaluator) + message(sprintf("nbrOfWorkers: %d", n)) + stopifnot(n == nworkers) + + plan(strategy) + n <- nbrOfWorkers() + message(sprintf("nbrOfWorkers: %d", n)) + stopifnot(n == nworkers) + + n <- nbrOfFreeWorkers() + message(sprintf("nbrOfFreeWorkers: %d", n)) + stopifnot(n == nworkers) + + n <- nbrOfFreeWorkers(background = TRUE) + message(sprintf("nbrOfFreeWorkers(background = TRUE): %d", n)) + # FIXME stopifnot(n == 0L) + + plan(strategy, workers = 1L) + n <- nbrOfWorkers() + message(sprintf("nbrOfWorkers: %d", n)) + stopifnot(n == max(1L, nworkers - 1L)) + + n <- nbrOfFreeWorkers() + message(sprintf("nbrOfFreeWorkers: %d", n)) + stopifnot(n == max(1L, nworkers - 1L)) + + n <- nbrOfFreeWorkers(background = TRUE) + message(sprintf("nbrOfFreeWorkers(background = TRUE): %d", n)) + # FIXME stopifnot(n == 0L) + + plan(strategy, workers = allButOneCore) + n <- nbrOfWorkers() + message(sprintf("nbrOfWorkers: %d", n)) + stopifnot(n == max(1L, nworkers - 1L)) + + n <- nbrOfFreeWorkers() + message(sprintf("nbrOfFreeWorkers: %d", n)) + stopifnot(n == max(1L, nworkers - 1L)) + + n <- nbrOfFreeWorkers(background = TRUE) + message(sprintf("nbrOfFreeWorkers(background = TRUE): %d", n)) + # FIXME stopifnot(n == 0L) + } ## for (strategy ...) Type of future: multisession nbrOfWorkers: 2 [17:28:30.817] plan(): Setting new future strategy stack: [17:28:30.818] List of future strategies: [17:28:30.818] 1. multisession: [17:28:30.818] - args: function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), envir = parent.frame()) [17:28:30.818] - tweaked: FALSE [17:28:30.818] - call: plan(strategy) [17:28:30.818] plan(): plan_init() of 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... [17:28:30.818] multisession: [17:28:30.818] - args: function (..., workers = availableCores(), lazy = FALSE, rscript_libs = .libPaths(), envir = parent.frame()) [17:28:30.818] - tweaked: FALSE [17:28:30.818] - call: plan(strategy) [17:28:30.823] getGlobalsAndPackages() ... [17:28:30.823] Not searching for globals [17:28:30.824] - globals: [0] [17:28:30.824] getGlobalsAndPackages() ... DONE [17:28:30.824] [local output] makeClusterPSOCK() ... [17:28:30.873] [local output] Workers: [n = 2] 'localhost', 'localhost' [17:28:30.882] [local output] Base port: 39398 [17:28:30.882] [local output] Getting setup options for 2 cluster nodes ... [17:28:30.882] [local output] - Node #1 of 2 ... [17:28:30.883] [local output] localMachine=TRUE => revtunnel=FALSE [17:28:30.885] Testing if worker's PID can be inferred: '"D:/RCompile/recent/R/bin/x64/Rscript" -e "try(suppressWarnings(cat(Sys.getpid(),file=\"D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c223648f3.pid\")), silent = TRUE)" -e "file.exists(\"D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c223648f3.pid\")"' [17:28:31.331] - Possible to infer worker's PID: TRUE [17:28:31.332] [local output] Rscript port: 39398 [17:28:31.333] [local output] - Node #2 of 2 ... [17:28:31.333] [local output] localMachine=TRUE => revtunnel=FALSE [17:28:31.335] [local output] Rscript port: 39398 [17:28:31.336] [local output] Getting setup options for 2 cluster nodes ... done [17:28:31.337] [local output] - Parallel setup requested for some PSOCK nodes [17:28:31.338] [local output] Setting up PSOCK nodes in parallel [17:28:31.338] List of 36 [17:28:31.338] $ worker : chr "localhost" [17:28:31.338] ..- attr(*, "localhost")= logi TRUE [17:28:31.338] $ master : chr "localhost" [17:28:31.338] $ port : int 39398 [17:28:31.338] $ connectTimeout : num 120 [17:28:31.338] $ timeout : num 120 [17:28:31.338] $ rscript : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\"" [17:28:31.338] $ homogeneous : logi TRUE [17:28:31.338] $ rscript_args : chr "--default-packages=datasets,utils,grDevices,graphics,stats,methods -e \"#label=nbrOfWorkers.R:164204:CRANWIN3:C"| __truncated__ [17:28:31.338] $ rscript_envs : NULL [17:28:31.338] $ rscript_libs : chr [1:2] "D:/temp/RtmpsXpk4j/RLIBS_1097c668d2fda" "D:/RCompile/recent/R/library" [17:28:31.338] $ rscript_startup : NULL [17:28:31.338] $ rscript_sh : chr [1:2] "cmd" "cmd" [17:28:31.338] $ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:31.338] $ methods : logi TRUE [17:28:31.338] $ socketOptions : chr "no-delay" [17:28:31.338] $ useXDR : logi FALSE [17:28:31.338] $ outfile : chr "/dev/null" [17:28:31.338] $ renice : int NA [17:28:31.338] $ rshcmd : NULL [17:28:31.338] $ user : chr(0) [17:28:31.338] $ revtunnel : logi FALSE [17:28:31.338] $ rshlogfile : NULL [17:28:31.338] $ rshopts : chr(0) [17:28:31.338] $ rank : int 1 [17:28:31.338] $ manual : logi FALSE [17:28:31.338] $ dryrun : logi FALSE [17:28:31.338] $ quiet : logi FALSE [17:28:31.338] $ setup_strategy : chr "parallel" [17:28:31.338] $ local_cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:31.338] $ pidfile : chr "D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c223648f3.pid" [17:28:31.338] $ rshcmd_label : NULL [17:28:31.338] $ rsh_call : NULL [17:28:31.338] $ cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:31.338] $ localMachine : logi TRUE [17:28:31.338] $ make_fcn :function (worker = getOption2("parallelly.localhost.hostname", "localhost"), [17:28:31.338] master = NULL, port, connectTimeout = getOption2("parallelly.makeNodePSOCK.connectTimeout", [17:28:31.338] 2 * 60), timeout = getOption2("parallelly.makeNodePSOCK.timeout", [17:28:31.338] 30 * 24 * 60 * 60), rscript = NULL, homogeneous = NULL, rscript_args = NULL, [17:28:31.338] rscript_envs = NULL, rscript_libs = NULL, rscript_startup = NULL, rscript_sh = c("auto", [17:28:31.338] "cmd", "sh", "none"), default_packages = c("datasets", "utils", [17:28:31.338] "grDevices", "graphics", "stats", if (methods) "methods"), methods = TRUE, [17:28:31.338] socketOptions = getOption2("parallelly.makeNodePSOCK.socketOptions", [17:28:31.338] "no-delay"), useXDR = getOption2("parallelly.makeNodePSOCK.useXDR", [17:28:31.338] FALSE), outfile = "/dev/null", renice = NA_integer_, rshcmd = getOption2("parallelly.makeNodePSOCK.rshcmd", [17:28:31.338] NULL), user = NULL, revtunnel = NA, rshlogfile = NULL, rshopts = getOption2("parallelly.makeNodePSOCK.rshopts", [17:28:31.338] NULL), rank = 1L, manual = FALSE, dryrun = FALSE, quiet = FALSE, [17:28:31.338] setup_strategy = getOption2("parallelly.makeNodePSOCK.setup_strategy", [17:28:31.338] "parallel"), action = c("launch", "options"), verbose = FALSE) [17:28:31.338] $ arguments :List of 28 [17:28:31.338] ..$ worker : chr "localhost" [17:28:31.338] ..$ master : NULL [17:28:31.338] ..$ port : int 39398 [17:28:31.338] ..$ connectTimeout : num 120 [17:28:31.338] ..$ timeout : num 120 [17:28:31.338] ..$ rscript : NULL [17:28:31.338] ..$ homogeneous : NULL [17:28:31.338] ..$ rscript_args : NULL [17:28:31.338] ..$ rscript_envs : NULL [17:28:31.338] ..$ rscript_libs : chr [1:2] "D:/temp/RtmpsXpk4j/RLIBS_1097c668d2fda" "D:/RCompile/recent/R/library" [17:28:31.338] ..$ rscript_startup : NULL [17:28:31.338] ..$ rscript_sh : chr "auto" [17:28:31.338] ..$ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:31.338] ..$ methods : logi TRUE [17:28:31.338] ..$ socketOptions : chr "no-delay" [17:28:31.338] ..$ useXDR : logi FALSE [17:28:31.338] ..$ outfile : chr "/dev/null" [17:28:31.338] ..$ renice : int NA [17:28:31.338] ..$ rshcmd : NULL [17:28:31.338] ..$ user : NULL [17:28:31.338] ..$ revtunnel : logi NA [17:28:31.338] ..$ rshlogfile : NULL [17:28:31.338] ..$ rshopts : NULL [17:28:31.338] ..$ rank : int 1 [17:28:31.338] ..$ manual : logi FALSE [17:28:31.338] ..$ dryrun : logi FALSE [17:28:31.338] ..$ quiet : logi FALSE [17:28:31.338] ..$ setup_strategy : chr "parallel" [17:28:31.338] - attr(*, "class")= chr [1:2] "makeNodePSOCKOptions" "makeNodeOptions" [17:28:31.371] [local output] System call to launch all workers: [17:28:31.371] [local output] "D:/RCompile/recent/R/bin/x64/Rscript" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "#label=nbrOfWorkers.R:164204:CRANWIN3:CRAN" -e "try(suppressWarnings(cat(Sys.getpid(),file=\"D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c223648f3.pid\")), silent = TRUE)" -e "options(socketOptions = \"no-delay\")" -e ".libPaths(c(\"D:/temp/RtmpsXpk4j/RLIBS_1097c668d2fda\",\"D:/RCompile/recent/R/library\"))" -e "workRSOCK <- tryCatch(parallel:::.workRSOCK, error=function(e) parallel:::.slaveRSOCK); workRSOCK()" MASTER=localhost PORT=39398 OUT=/dev/null TIMEOUT=120 XDR=FALSE SETUPTIMEOUT=120 SETUPSTRATEGY=parallel [17:28:31.371] [local output] Starting PSOCK main server [17:28:31.382] [local output] Workers launched [17:28:31.383] [local output] Waiting for workers to connect back [17:28:31.383] - [local output] 0 workers out of 2 ready [17:28:31.631] - [local output] 0 workers out of 2 ready [17:28:31.632] - [local output] 1 workers out of 2 ready [17:28:31.656] - [local output] 1 workers out of 2 ready [17:28:31.657] - [local output] 2 workers out of 2 ready [17:28:31.657] [local output] Launching of 2 workers completed [17:28:31.658] [local output] Number of nodes in cluster: 2 [17:28:31.658] [local output] Collecting session information from 2 workers [17:28:31.660] [local output] - Worker #1 of 2 [17:28:31.661] [local output] - Worker #2 of 2 [17:28:31.662] [local output] makeClusterPSOCK() ... done [17:28:31.680] Packages needed by the future expression (n = 0): [17:28:31.680] Packages needed by future strategies (n = 0): [17:28:31.682] { [17:28:31.682] { [17:28:31.682] { [17:28:31.682] ...future.startTime <- base::Sys.time() [17:28:31.682] { [17:28:31.682] { [17:28:31.682] { [17:28:31.682] { [17:28:31.682] base::local({ [17:28:31.682] has_future <- base::requireNamespace("future", [17:28:31.682] quietly = TRUE) [17:28:31.682] if (has_future) { [17:28:31.682] ns <- base::getNamespace("future") [17:28:31.682] version <- ns[[".package"]][["version"]] [17:28:31.682] if (is.null(version)) [17:28:31.682] version <- utils::packageVersion("future") [17:28:31.682] } [17:28:31.682] else { [17:28:31.682] version <- NULL [17:28:31.682] } [17:28:31.682] if (!has_future || version < "1.8.0") { [17:28:31.682] info <- base::c(r_version = base::gsub("R version ", [17:28:31.682] "", base::R.version$version.string), [17:28:31.682] platform = base::sprintf("%s (%s-bit)", [17:28:31.682] base::R.version$platform, 8 * base::.Machine$sizeof.pointer), [17:28:31.682] os = base::paste(base::Sys.info()[base::c("sysname", [17:28:31.682] "release", "version")], collapse = " "), [17:28:31.682] hostname = base::Sys.info()[["nodename"]]) [17:28:31.682] info <- base::sprintf("%s: %s", base::names(info), [17:28:31.682] info) [17:28:31.682] info <- base::paste(info, collapse = "; ") [17:28:31.682] if (!has_future) { [17:28:31.682] msg <- base::sprintf("Package 'future' is not installed on worker (%s)", [17:28:31.682] info) [17:28:31.682] } [17:28:31.682] else { [17:28:31.682] msg <- base::sprintf("Package 'future' on worker (%s) must be of version >= 1.8.0: %s", [17:28:31.682] info, version) [17:28:31.682] } [17:28:31.682] base::stop(msg) [17:28:31.682] } [17:28:31.682] }) [17:28:31.682] } [17:28:31.682] ...future.mc.cores.old <- base::getOption("mc.cores") [17:28:31.682] base::options(mc.cores = 1L) [17:28:31.682] } [17:28:31.682] ...future.strategy.old <- future::plan("list") [17:28:31.682] options(future.plan = NULL) [17:28:31.682] Sys.unsetenv("R_FUTURE_PLAN") [17:28:31.682] future::plan("default", .cleanup = FALSE, .init = FALSE) [17:28:31.682] } [17:28:31.682] ...future.workdir <- getwd() [17:28:31.682] } [17:28:31.682] ...future.oldOptions <- base::as.list(base::.Options) [17:28:31.682] ...future.oldEnvVars <- base::Sys.getenv() [17:28:31.682] } [17:28:31.682] base::options(future.startup.script = FALSE, future.globals.onMissing = NULL, [17:28:31.682] future.globals.maxSize = NULL, future.globals.method = NULL, [17:28:31.682] future.globals.onMissing = NULL, future.globals.onReference = NULL, [17:28:31.682] future.globals.resolve = NULL, future.resolve.recursive = NULL, [17:28:31.682] future.rng.onMisuse = NULL, future.rng.onMisuse.keepFuture = NULL, [17:28:31.682] future.stdout.windows.reencode = NULL, width = 80L) [17:28:31.682] ...future.futureOptionsAdded <- base::setdiff(base::names(base::.Options), [17:28:31.682] base::names(...future.oldOptions)) [17:28:31.682] } [17:28:31.682] if (FALSE) { [17:28:31.682] } [17:28:31.682] else { [17:28:31.682] if (TRUE) { [17:28:31.682] ...future.stdout <- base::rawConnection(base::raw(0L), [17:28:31.682] open = "w") [17:28:31.682] } [17:28:31.682] else { [17:28:31.682] ...future.stdout <- base::file(base::switch(.Platform$OS.type, [17:28:31.682] windows = "NUL", "/dev/null"), open = "w") [17:28:31.682] } [17:28:31.682] base::sink(...future.stdout, type = "output", split = FALSE) [17:28:31.682] base::on.exit(if (!base::is.null(...future.stdout)) { [17:28:31.682] base::sink(type = "output", split = FALSE) [17:28:31.682] base::close(...future.stdout) [17:28:31.682] }, add = TRUE) [17:28:31.682] } [17:28:31.682] ...future.frame <- base::sys.nframe() [17:28:31.682] ...future.conditions <- base::list() [17:28:31.682] ...future.rng <- base::globalenv()$.Random.seed [17:28:31.682] if (FALSE) { [17:28:31.682] ...future.globalenv.names <- c(base::names(base::.GlobalEnv), [17:28:31.682] "...future.value", "...future.globalenv.names", ".Random.seed") [17:28:31.682] } [17:28:31.682] ...future.result <- base::tryCatch({ [17:28:31.682] base::withCallingHandlers({ [17:28:31.682] ...future.value <- base::withVisible(base::local({ [17:28:31.682] ...future.makeSendCondition <- base::local({ [17:28:31.682] sendCondition <- NULL [17:28:31.682] function(frame = 1L) { [17:28:31.682] if (is.function(sendCondition)) [17:28:31.682] return(sendCondition) [17:28:31.682] ns <- getNamespace("parallel") [17:28:31.682] if (exists("sendData", mode = "function", [17:28:31.682] envir = ns)) { [17:28:31.682] parallel_sendData <- get("sendData", mode = "function", [17:28:31.682] envir = ns) [17:28:31.682] envir <- sys.frame(frame) [17:28:31.682] master <- NULL [17:28:31.682] while (!identical(envir, .GlobalEnv) && [17:28:31.682] !identical(envir, emptyenv())) { [17:28:31.682] if (exists("master", mode = "list", envir = envir, [17:28:31.682] inherits = FALSE)) { [17:28:31.682] master <- get("master", mode = "list", [17:28:31.682] envir = envir, inherits = FALSE) [17:28:31.682] if (inherits(master, c("SOCKnode", [17:28:31.682] "SOCK0node"))) { [17:28:31.682] sendCondition <<- function(cond) { [17:28:31.682] data <- list(type = "VALUE", value = cond, [17:28:31.682] success = TRUE) [17:28:31.682] parallel_sendData(master, data) [17:28:31.682] } [17:28:31.682] return(sendCondition) [17:28:31.682] } [17:28:31.682] } [17:28:31.682] frame <- frame + 1L [17:28:31.682] envir <- sys.frame(frame) [17:28:31.682] } [17:28:31.682] } [17:28:31.682] sendCondition <<- function(cond) NULL [17:28:31.682] } [17:28:31.682] }) [17:28:31.682] withCallingHandlers({ [17:28:31.682] NA [17:28:31.682] }, immediateCondition = function(cond) { [17:28:31.682] sendCondition <- ...future.makeSendCondition() [17:28:31.682] sendCondition(cond) [17:28:31.682] muffleCondition <- function (cond, pattern = "^muffle") [17:28:31.682] { [17:28:31.682] inherits <- base::inherits [17:28:31.682] invokeRestart <- base::invokeRestart [17:28:31.682] is.null <- base::is.null [17:28:31.682] muffled <- FALSE [17:28:31.682] if (inherits(cond, "message")) { [17:28:31.682] muffled <- grepl(pattern, "muffleMessage") [17:28:31.682] if (muffled) [17:28:31.682] invokeRestart("muffleMessage") [17:28:31.682] } [17:28:31.682] else if (inherits(cond, "warning")) { [17:28:31.682] muffled <- grepl(pattern, "muffleWarning") [17:28:31.682] if (muffled) [17:28:31.682] invokeRestart("muffleWarning") [17:28:31.682] } [17:28:31.682] else if (inherits(cond, "condition")) { [17:28:31.682] if (!is.null(pattern)) { [17:28:31.682] computeRestarts <- base::computeRestarts [17:28:31.682] grepl <- base::grepl [17:28:31.682] restarts <- computeRestarts(cond) [17:28:31.682] for (restart in restarts) { [17:28:31.682] name <- restart$name [17:28:31.682] if (is.null(name)) [17:28:31.682] next [17:28:31.682] if (!grepl(pattern, name)) [17:28:31.682] next [17:28:31.682] invokeRestart(restart) [17:28:31.682] muffled <- TRUE [17:28:31.682] break [17:28:31.682] } [17:28:31.682] } [17:28:31.682] } [17:28:31.682] invisible(muffled) [17:28:31.682] } [17:28:31.682] muffleCondition(cond) [17:28:31.682] }) [17:28:31.682] })) [17:28:31.682] future::FutureResult(value = ...future.value$value, [17:28:31.682] visible = ...future.value$visible, rng = !identical(base::globalenv()$.Random.seed, [17:28:31.682] ...future.rng), globalenv = if (FALSE) [17:28:31.682] list(added = base::setdiff(base::names(base::.GlobalEnv), [17:28:31.682] ...future.globalenv.names)) [17:28:31.682] else NULL, started = ...future.startTime, version = "1.8") [17:28:31.682] }, condition = base::local({ [17:28:31.682] c <- base::c [17:28:31.682] inherits <- base::inherits [17:28:31.682] invokeRestart <- base::invokeRestart [17:28:31.682] length <- base::length [17:28:31.682] list <- base::list [17:28:31.682] seq.int <- base::seq.int [17:28:31.682] signalCondition <- base::signalCondition [17:28:31.682] sys.calls <- base::sys.calls [17:28:31.682] `[[` <- base::`[[` [17:28:31.682] `+` <- base::`+` [17:28:31.682] `<<-` <- base::`<<-` [17:28:31.682] sysCalls <- function(calls = sys.calls(), from = 1L) { [17:28:31.682] calls[seq.int(from = from + 12L, to = length(calls) - [17:28:31.682] 3L)] [17:28:31.682] } [17:28:31.682] function(cond) { [17:28:31.682] is_error <- inherits(cond, "error") [17:28:31.682] ignore <- !is_error && !is.null(NULL) && inherits(cond, [17:28:31.682] NULL) [17:28:31.682] if (is_error) { [17:28:31.682] sessionInformation <- function() { [17:28:31.682] list(r = base::R.Version(), locale = base::Sys.getlocale(), [17:28:31.682] rngkind = base::RNGkind(), namespaces = base::loadedNamespaces(), [17:28:31.682] search = base::search(), system = base::Sys.info()) [17:28:31.682] } [17:28:31.682] ...future.conditions[[length(...future.conditions) + [17:28:31.682] 1L]] <<- list(condition = cond, calls = c(sysCalls(from = ...future.frame), [17:28:31.682] cond$call), session = sessionInformation(), [17:28:31.682] timestamp = base::Sys.time(), signaled = 0L) [17:28:31.682] signalCondition(cond) [17:28:31.682] } [17:28:31.682] else if (!ignore && TRUE && inherits(cond, c("condition", [17:28:31.682] "immediateCondition"))) { [17:28:31.682] signal <- TRUE && inherits(cond, "immediateCondition") [17:28:31.682] ...future.conditions[[length(...future.conditions) + [17:28:31.682] 1L]] <<- list(condition = cond, signaled = base::as.integer(signal)) [17:28:31.682] if (TRUE && !signal) { [17:28:31.682] muffleCondition <- function (cond, pattern = "^muffle") [17:28:31.682] { [17:28:31.682] inherits <- base::inherits [17:28:31.682] invokeRestart <- base::invokeRestart [17:28:31.682] is.null <- base::is.null [17:28:31.682] muffled <- FALSE [17:28:31.682] if (inherits(cond, "message")) { [17:28:31.682] muffled <- grepl(pattern, "muffleMessage") [17:28:31.682] if (muffled) [17:28:31.682] invokeRestart("muffleMessage") [17:28:31.682] } [17:28:31.682] else if (inherits(cond, "warning")) { [17:28:31.682] muffled <- grepl(pattern, "muffleWarning") [17:28:31.682] if (muffled) [17:28:31.682] invokeRestart("muffleWarning") [17:28:31.682] } [17:28:31.682] else if (inherits(cond, "condition")) { [17:28:31.682] if (!is.null(pattern)) { [17:28:31.682] computeRestarts <- base::computeRestarts [17:28:31.682] grepl <- base::grepl [17:28:31.682] restarts <- computeRestarts(cond) [17:28:31.682] for (restart in restarts) { [17:28:31.682] name <- restart$name [17:28:31.682] if (is.null(name)) [17:28:31.682] next [17:28:31.682] if (!grepl(pattern, name)) [17:28:31.682] next [17:28:31.682] invokeRestart(restart) [17:28:31.682] muffled <- TRUE [17:28:31.682] break [17:28:31.682] } [17:28:31.682] } [17:28:31.682] } [17:28:31.682] invisible(muffled) [17:28:31.682] } [17:28:31.682] muffleCondition(cond, pattern = "^muffle") [17:28:31.682] } [17:28:31.682] } [17:28:31.682] else { [17:28:31.682] if (TRUE) { [17:28:31.682] muffleCondition <- function (cond, pattern = "^muffle") [17:28:31.682] { [17:28:31.682] inherits <- base::inherits [17:28:31.682] invokeRestart <- base::invokeRestart [17:28:31.682] is.null <- base::is.null [17:28:31.682] muffled <- FALSE [17:28:31.682] if (inherits(cond, "message")) { [17:28:31.682] muffled <- grepl(pattern, "muffleMessage") [17:28:31.682] if (muffled) [17:28:31.682] invokeRestart("muffleMessage") [17:28:31.682] } [17:28:31.682] else if (inherits(cond, "warning")) { [17:28:31.682] muffled <- grepl(pattern, "muffleWarning") [17:28:31.682] if (muffled) [17:28:31.682] invokeRestart("muffleWarning") [17:28:31.682] } [17:28:31.682] else if (inherits(cond, "condition")) { [17:28:31.682] if (!is.null(pattern)) { [17:28:31.682] computeRestarts <- base::computeRestarts [17:28:31.682] grepl <- base::grepl [17:28:31.682] restarts <- computeRestarts(cond) [17:28:31.682] for (restart in restarts) { [17:28:31.682] name <- restart$name [17:28:31.682] if (is.null(name)) [17:28:31.682] next [17:28:31.682] if (!grepl(pattern, name)) [17:28:31.682] next [17:28:31.682] invokeRestart(restart) [17:28:31.682] muffled <- TRUE [17:28:31.682] break [17:28:31.682] } [17:28:31.682] } [17:28:31.682] } [17:28:31.682] invisible(muffled) [17:28:31.682] } [17:28:31.682] muffleCondition(cond, pattern = "^muffle") [17:28:31.682] } [17:28:31.682] } [17:28:31.682] } [17:28:31.682] })) [17:28:31.682] }, error = function(ex) { [17:28:31.682] base::structure(base::list(value = NULL, visible = NULL, [17:28:31.682] conditions = ...future.conditions, rng = !identical(base::globalenv()$.Random.seed, [17:28:31.682] ...future.rng), started = ...future.startTime, [17:28:31.682] finished = Sys.time(), session_uuid = NA_character_, [17:28:31.682] version = "1.8"), class = "FutureResult") [17:28:31.682] }, finally = { [17:28:31.682] if (!identical(...future.workdir, getwd())) [17:28:31.682] setwd(...future.workdir) [17:28:31.682] { [17:28:31.682] if (identical(getOption("nwarnings"), ...future.oldOptions$nwarnings)) { [17:28:31.682] ...future.oldOptions$nwarnings <- NULL [17:28:31.682] } [17:28:31.682] base::options(...future.oldOptions) [17:28:31.682] if (.Platform$OS.type == "windows") { [17:28:31.682] old_names <- names(...future.oldEnvVars) [17:28:31.682] envs <- base::Sys.getenv() [17:28:31.682] names <- names(envs) [17:28:31.682] common <- intersect(names, old_names) [17:28:31.682] added <- setdiff(names, old_names) [17:28:31.682] removed <- setdiff(old_names, names) [17:28:31.682] changed <- common[...future.oldEnvVars[common] != [17:28:31.682] envs[common]] [17:28:31.682] NAMES <- toupper(changed) [17:28:31.682] args <- list() [17:28:31.682] for (kk in seq_along(NAMES)) { [17:28:31.682] name <- changed[[kk]] [17:28:31.682] NAME <- NAMES[[kk]] [17:28:31.682] if (name != NAME && is.element(NAME, old_names)) [17:28:31.682] next [17:28:31.682] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:31.682] } [17:28:31.682] NAMES <- toupper(added) [17:28:31.682] for (kk in seq_along(NAMES)) { [17:28:31.682] name <- added[[kk]] [17:28:31.682] NAME <- NAMES[[kk]] [17:28:31.682] if (name != NAME && is.element(NAME, old_names)) [17:28:31.682] next [17:28:31.682] args[[name]] <- "" [17:28:31.682] } [17:28:31.682] NAMES <- toupper(removed) [17:28:31.682] for (kk in seq_along(NAMES)) { [17:28:31.682] name <- removed[[kk]] [17:28:31.682] NAME <- NAMES[[kk]] [17:28:31.682] if (name != NAME && is.element(NAME, old_names)) [17:28:31.682] next [17:28:31.682] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:31.682] } [17:28:31.682] if (length(args) > 0) [17:28:31.682] base::do.call(base::Sys.setenv, args = args) [17:28:31.682] args <- names <- old_names <- NAMES <- envs <- common <- added <- removed <- NULL [17:28:31.682] } [17:28:31.682] else { [17:28:31.682] base::do.call(base::Sys.setenv, args = base::as.list(...future.oldEnvVars)) [17:28:31.682] } [17:28:31.682] { [17:28:31.682] if (base::length(...future.futureOptionsAdded) > [17:28:31.682] 0L) { [17:28:31.682] opts <- base::vector("list", length = base::length(...future.futureOptionsAdded)) [17:28:31.682] base::names(opts) <- ...future.futureOptionsAdded [17:28:31.682] base::options(opts) [17:28:31.682] } [17:28:31.682] { [17:28:31.682] { [17:28:31.682] base::options(mc.cores = ...future.mc.cores.old) [17:28:31.682] NULL [17:28:31.682] } [17:28:31.682] options(future.plan = NULL) [17:28:31.682] if (is.na(NA_character_)) [17:28:31.682] Sys.unsetenv("R_FUTURE_PLAN") [17:28:31.682] else Sys.setenv(R_FUTURE_PLAN = NA_character_) [17:28:31.682] future::plan(...future.strategy.old, .cleanup = FALSE, [17:28:31.682] .init = FALSE) [17:28:31.682] } [17:28:31.682] } [17:28:31.682] } [17:28:31.682] }) [17:28:31.682] if (TRUE) { [17:28:31.682] base::sink(type = "output", split = FALSE) [17:28:31.682] if (TRUE) { [17:28:31.682] ...future.result$stdout <- base::rawToChar(base::rawConnectionValue(...future.stdout)) [17:28:31.682] } [17:28:31.682] else { [17:28:31.682] ...future.result["stdout"] <- base::list(NULL) [17:28:31.682] } [17:28:31.682] base::close(...future.stdout) [17:28:31.682] ...future.stdout <- NULL [17:28:31.682] } [17:28:31.682] ...future.result$conditions <- ...future.conditions [17:28:31.682] ...future.result$finished <- base::Sys.time() [17:28:31.682] ...future.result [17:28:31.682] } [17:28:31.823] MultisessionFuture started [17:28:31.824] result() for ClusterFuture ... [17:28:31.825] receiveMessageFromWorker() for ClusterFuture ... [17:28:31.826] - Validating connection of MultisessionFuture [17:28:31.913] - received message: FutureResult [17:28:31.914] - Received FutureResult [17:28:31.921] - Erased future from FutureRegistry [17:28:31.922] result() for ClusterFuture ... [17:28:31.922] - result already collected: FutureResult [17:28:31.922] result() for ClusterFuture ... done [17:28:31.923] receiveMessageFromWorker() for ClusterFuture ... done [17:28:31.923] result() for ClusterFuture ... done [17:28:31.924] result() for ClusterFuture ... [17:28:31.924] - result already collected: FutureResult [17:28:31.924] result() for ClusterFuture ... done [17:28:31.925] plan(): plan_init() of 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... DONE [17:28:31.930] plan(): nbrOfWorkers() = 2 nbrOfWorkers: 2 [17:28:31.943] getGlobalsAndPackages() ... [17:28:31.943] [17:28:31.944] - globals: [0] [17:28:31.944] getGlobalsAndPackages() ... DONE nbrOfFreeWorkers: 2 [17:28:31.968] getGlobalsAndPackages() ... [17:28:31.968] [17:28:31.969] - globals: [0] [17:28:31.969] getGlobalsAndPackages() ... DONE nbrOfFreeWorkers(background = TRUE): 2 [17:28:31.986] plan(): Setting new future strategy stack: [17:28:31.986] List of future strategies: [17:28:31.986] 1. multisession: [17:28:31.986] - args: function (..., workers = 1L, envir = parent.frame()) [17:28:31.986] - tweaked: TRUE [17:28:31.986] - call: plan(strategy, workers = 1L) [17:28:31.996] plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... [17:28:31.996] multisession: [17:28:31.996] - args: function (..., workers = 1L, envir = parent.frame()) [17:28:31.996] - tweaked: TRUE [17:28:31.996] - call: plan(strategy, workers = 1L) [17:28:31.998] getGlobalsAndPackages() ... [17:28:31.998] Not searching for globals [17:28:31.998] - globals: [0] [17:28:31.999] getGlobalsAndPackages() ... DONE [17:28:32.000] Packages needed by the future expression (n = 0): [17:28:32.001] Packages needed by future strategies (n = 0): [17:28:32.002] { [17:28:32.002] { [17:28:32.002] { [17:28:32.002] ...future.startTime <- base::Sys.time() [17:28:32.002] { [17:28:32.002] { [17:28:32.002] { [17:28:32.002] base::local({ [17:28:32.002] has_future <- base::requireNamespace("future", [17:28:32.002] quietly = TRUE) [17:28:32.002] if (has_future) { [17:28:32.002] ns <- base::getNamespace("future") [17:28:32.002] version <- ns[[".package"]][["version"]] [17:28:32.002] if (is.null(version)) [17:28:32.002] version <- utils::packageVersion("future") [17:28:32.002] } [17:28:32.002] else { [17:28:32.002] version <- NULL [17:28:32.002] } [17:28:32.002] if (!has_future || version < "1.8.0") { [17:28:32.002] info <- base::c(r_version = base::gsub("R version ", [17:28:32.002] "", base::R.version$version.string), [17:28:32.002] platform = base::sprintf("%s (%s-bit)", [17:28:32.002] base::R.version$platform, 8 * base::.Machine$sizeof.pointer), [17:28:32.002] os = base::paste(base::Sys.info()[base::c("sysname", [17:28:32.002] "release", "version")], collapse = " "), [17:28:32.002] hostname = base::Sys.info()[["nodename"]]) [17:28:32.002] info <- base::sprintf("%s: %s", base::names(info), [17:28:32.002] info) [17:28:32.002] info <- base::paste(info, collapse = "; ") [17:28:32.002] if (!has_future) { [17:28:32.002] msg <- base::sprintf("Package 'future' is not installed on worker (%s)", [17:28:32.002] info) [17:28:32.002] } [17:28:32.002] else { [17:28:32.002] msg <- base::sprintf("Package 'future' on worker (%s) must be of version >= 1.8.0: %s", [17:28:32.002] info, version) [17:28:32.002] } [17:28:32.002] base::stop(msg) [17:28:32.002] } [17:28:32.002] }) [17:28:32.002] } [17:28:32.002] ...future.strategy.old <- future::plan("list") [17:28:32.002] options(future.plan = NULL) [17:28:32.002] Sys.unsetenv("R_FUTURE_PLAN") [17:28:32.002] future::plan("default", .cleanup = FALSE, .init = FALSE) [17:28:32.002] } [17:28:32.002] ...future.workdir <- getwd() [17:28:32.002] } [17:28:32.002] ...future.oldOptions <- base::as.list(base::.Options) [17:28:32.002] ...future.oldEnvVars <- base::Sys.getenv() [17:28:32.002] } [17:28:32.002] base::options(future.startup.script = FALSE, future.globals.onMissing = NULL, [17:28:32.002] future.globals.maxSize = NULL, future.globals.method = NULL, [17:28:32.002] future.globals.onMissing = NULL, future.globals.onReference = NULL, [17:28:32.002] future.globals.resolve = NULL, future.resolve.recursive = NULL, [17:28:32.002] future.rng.onMisuse = NULL, future.rng.onMisuse.keepFuture = NULL, [17:28:32.002] future.stdout.windows.reencode = NULL, width = 80L) [17:28:32.002] ...future.futureOptionsAdded <- base::setdiff(base::names(base::.Options), [17:28:32.002] base::names(...future.oldOptions)) [17:28:32.002] } [17:28:32.002] if (FALSE) { [17:28:32.002] } [17:28:32.002] else { [17:28:32.002] if (TRUE) { [17:28:32.002] ...future.stdout <- base::rawConnection(base::raw(0L), [17:28:32.002] open = "w") [17:28:32.002] } [17:28:32.002] else { [17:28:32.002] ...future.stdout <- base::file(base::switch(.Platform$OS.type, [17:28:32.002] windows = "NUL", "/dev/null"), open = "w") [17:28:32.002] } [17:28:32.002] base::sink(...future.stdout, type = "output", split = FALSE) [17:28:32.002] base::on.exit(if (!base::is.null(...future.stdout)) { [17:28:32.002] base::sink(type = "output", split = FALSE) [17:28:32.002] base::close(...future.stdout) [17:28:32.002] }, add = TRUE) [17:28:32.002] } [17:28:32.002] ...future.frame <- base::sys.nframe() [17:28:32.002] ...future.conditions <- base::list() [17:28:32.002] ...future.rng <- base::globalenv()$.Random.seed [17:28:32.002] if (FALSE) { [17:28:32.002] ...future.globalenv.names <- c(base::names(base::.GlobalEnv), [17:28:32.002] "...future.value", "...future.globalenv.names", ".Random.seed") [17:28:32.002] } [17:28:32.002] ...future.result <- base::tryCatch({ [17:28:32.002] base::withCallingHandlers({ [17:28:32.002] ...future.value <- base::withVisible(base::local(NA)) [17:28:32.002] future::FutureResult(value = ...future.value$value, [17:28:32.002] visible = ...future.value$visible, rng = !identical(base::globalenv()$.Random.seed, [17:28:32.002] ...future.rng), globalenv = if (FALSE) [17:28:32.002] list(added = base::setdiff(base::names(base::.GlobalEnv), [17:28:32.002] ...future.globalenv.names)) [17:28:32.002] else NULL, started = ...future.startTime, version = "1.8") [17:28:32.002] }, condition = base::local({ [17:28:32.002] c <- base::c [17:28:32.002] inherits <- base::inherits [17:28:32.002] invokeRestart <- base::invokeRestart [17:28:32.002] length <- base::length [17:28:32.002] list <- base::list [17:28:32.002] seq.int <- base::seq.int [17:28:32.002] signalCondition <- base::signalCondition [17:28:32.002] sys.calls <- base::sys.calls [17:28:32.002] `[[` <- base::`[[` [17:28:32.002] `+` <- base::`+` [17:28:32.002] `<<-` <- base::`<<-` [17:28:32.002] sysCalls <- function(calls = sys.calls(), from = 1L) { [17:28:32.002] calls[seq.int(from = from + 12L, to = length(calls) - [17:28:32.002] 3L)] [17:28:32.002] } [17:28:32.002] function(cond) { [17:28:32.002] is_error <- inherits(cond, "error") [17:28:32.002] ignore <- !is_error && !is.null(NULL) && inherits(cond, [17:28:32.002] NULL) [17:28:32.002] if (is_error) { [17:28:32.002] sessionInformation <- function() { [17:28:32.002] list(r = base::R.Version(), locale = base::Sys.getlocale(), [17:28:32.002] rngkind = base::RNGkind(), namespaces = base::loadedNamespaces(), [17:28:32.002] search = base::search(), system = base::Sys.info()) [17:28:32.002] } [17:28:32.002] ...future.conditions[[length(...future.conditions) + [17:28:32.002] 1L]] <<- list(condition = cond, calls = c(sysCalls(from = ...future.frame), [17:28:32.002] cond$call), session = sessionInformation(), [17:28:32.002] timestamp = base::Sys.time(), signaled = 0L) [17:28:32.002] signalCondition(cond) [17:28:32.002] } [17:28:32.002] else if (!ignore && TRUE && inherits(cond, c("condition", [17:28:32.002] "immediateCondition"))) { [17:28:32.002] signal <- TRUE && inherits(cond, "immediateCondition") [17:28:32.002] ...future.conditions[[length(...future.conditions) + [17:28:32.002] 1L]] <<- list(condition = cond, signaled = base::as.integer(signal)) [17:28:32.002] if (TRUE && !signal) { [17:28:32.002] muffleCondition <- function (cond, pattern = "^muffle") [17:28:32.002] { [17:28:32.002] inherits <- base::inherits [17:28:32.002] invokeRestart <- base::invokeRestart [17:28:32.002] is.null <- base::is.null [17:28:32.002] muffled <- FALSE [17:28:32.002] if (inherits(cond, "message")) { [17:28:32.002] muffled <- grepl(pattern, "muffleMessage") [17:28:32.002] if (muffled) [17:28:32.002] invokeRestart("muffleMessage") [17:28:32.002] } [17:28:32.002] else if (inherits(cond, "warning")) { [17:28:32.002] muffled <- grepl(pattern, "muffleWarning") [17:28:32.002] if (muffled) [17:28:32.002] invokeRestart("muffleWarning") [17:28:32.002] } [17:28:32.002] else if (inherits(cond, "condition")) { [17:28:32.002] if (!is.null(pattern)) { [17:28:32.002] computeRestarts <- base::computeRestarts [17:28:32.002] grepl <- base::grepl [17:28:32.002] restarts <- computeRestarts(cond) [17:28:32.002] for (restart in restarts) { [17:28:32.002] name <- restart$name [17:28:32.002] if (is.null(name)) [17:28:32.002] next [17:28:32.002] if (!grepl(pattern, name)) [17:28:32.002] next [17:28:32.002] invokeRestart(restart) [17:28:32.002] muffled <- TRUE [17:28:32.002] break [17:28:32.002] } [17:28:32.002] } [17:28:32.002] } [17:28:32.002] invisible(muffled) [17:28:32.002] } [17:28:32.002] muffleCondition(cond, pattern = "^muffle") [17:28:32.002] } [17:28:32.002] } [17:28:32.002] else { [17:28:32.002] if (TRUE) { [17:28:32.002] muffleCondition <- function (cond, pattern = "^muffle") [17:28:32.002] { [17:28:32.002] inherits <- base::inherits [17:28:32.002] invokeRestart <- base::invokeRestart [17:28:32.002] is.null <- base::is.null [17:28:32.002] muffled <- FALSE [17:28:32.002] if (inherits(cond, "message")) { [17:28:32.002] muffled <- grepl(pattern, "muffleMessage") [17:28:32.002] if (muffled) [17:28:32.002] invokeRestart("muffleMessage") [17:28:32.002] } [17:28:32.002] else if (inherits(cond, "warning")) { [17:28:32.002] muffled <- grepl(pattern, "muffleWarning") [17:28:32.002] if (muffled) [17:28:32.002] invokeRestart("muffleWarning") [17:28:32.002] } [17:28:32.002] else if (inherits(cond, "condition")) { [17:28:32.002] if (!is.null(pattern)) { [17:28:32.002] computeRestarts <- base::computeRestarts [17:28:32.002] grepl <- base::grepl [17:28:32.002] restarts <- computeRestarts(cond) [17:28:32.002] for (restart in restarts) { [17:28:32.002] name <- restart$name [17:28:32.002] if (is.null(name)) [17:28:32.002] next [17:28:32.002] if (!grepl(pattern, name)) [17:28:32.002] next [17:28:32.002] invokeRestart(restart) [17:28:32.002] muffled <- TRUE [17:28:32.002] break [17:28:32.002] } [17:28:32.002] } [17:28:32.002] } [17:28:32.002] invisible(muffled) [17:28:32.002] } [17:28:32.002] muffleCondition(cond, pattern = "^muffle") [17:28:32.002] } [17:28:32.002] } [17:28:32.002] } [17:28:32.002] })) [17:28:32.002] }, error = function(ex) { [17:28:32.002] base::structure(base::list(value = NULL, visible = NULL, [17:28:32.002] conditions = ...future.conditions, rng = !identical(base::globalenv()$.Random.seed, [17:28:32.002] ...future.rng), started = ...future.startTime, [17:28:32.002] finished = Sys.time(), session_uuid = NA_character_, [17:28:32.002] version = "1.8"), class = "FutureResult") [17:28:32.002] }, finally = { [17:28:32.002] if (!identical(...future.workdir, getwd())) [17:28:32.002] setwd(...future.workdir) [17:28:32.002] { [17:28:32.002] if (identical(getOption("nwarnings"), ...future.oldOptions$nwarnings)) { [17:28:32.002] ...future.oldOptions$nwarnings <- NULL [17:28:32.002] } [17:28:32.002] base::options(...future.oldOptions) [17:28:32.002] if (.Platform$OS.type == "windows") { [17:28:32.002] old_names <- names(...future.oldEnvVars) [17:28:32.002] envs <- base::Sys.getenv() [17:28:32.002] names <- names(envs) [17:28:32.002] common <- intersect(names, old_names) [17:28:32.002] added <- setdiff(names, old_names) [17:28:32.002] removed <- setdiff(old_names, names) [17:28:32.002] changed <- common[...future.oldEnvVars[common] != [17:28:32.002] envs[common]] [17:28:32.002] NAMES <- toupper(changed) [17:28:32.002] args <- list() [17:28:32.002] for (kk in seq_along(NAMES)) { [17:28:32.002] name <- changed[[kk]] [17:28:32.002] NAME <- NAMES[[kk]] [17:28:32.002] if (name != NAME && is.element(NAME, old_names)) [17:28:32.002] next [17:28:32.002] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:32.002] } [17:28:32.002] NAMES <- toupper(added) [17:28:32.002] for (kk in seq_along(NAMES)) { [17:28:32.002] name <- added[[kk]] [17:28:32.002] NAME <- NAMES[[kk]] [17:28:32.002] if (name != NAME && is.element(NAME, old_names)) [17:28:32.002] next [17:28:32.002] args[[name]] <- "" [17:28:32.002] } [17:28:32.002] NAMES <- toupper(removed) [17:28:32.002] for (kk in seq_along(NAMES)) { [17:28:32.002] name <- removed[[kk]] [17:28:32.002] NAME <- NAMES[[kk]] [17:28:32.002] if (name != NAME && is.element(NAME, old_names)) [17:28:32.002] next [17:28:32.002] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:32.002] } [17:28:32.002] if (length(args) > 0) [17:28:32.002] base::do.call(base::Sys.setenv, args = args) [17:28:32.002] args <- names <- old_names <- NAMES <- envs <- common <- added <- removed <- NULL [17:28:32.002] } [17:28:32.002] else { [17:28:32.002] base::do.call(base::Sys.setenv, args = base::as.list(...future.oldEnvVars)) [17:28:32.002] } [17:28:32.002] { [17:28:32.002] if (base::length(...future.futureOptionsAdded) > [17:28:32.002] 0L) { [17:28:32.002] opts <- base::vector("list", length = base::length(...future.futureOptionsAdded)) [17:28:32.002] base::names(opts) <- ...future.futureOptionsAdded [17:28:32.002] base::options(opts) [17:28:32.002] } [17:28:32.002] { [17:28:32.002] { [17:28:32.002] NULL [17:28:32.002] RNGkind("Mersenne-Twister") [17:28:32.002] base::rm(list = ".Random.seed", envir = base::globalenv(), [17:28:32.002] inherits = FALSE) [17:28:32.002] } [17:28:32.002] options(future.plan = NULL) [17:28:32.002] if (is.na(NA_character_)) [17:28:32.002] Sys.unsetenv("R_FUTURE_PLAN") [17:28:32.002] else Sys.setenv(R_FUTURE_PLAN = NA_character_) [17:28:32.002] future::plan(...future.strategy.old, .cleanup = FALSE, [17:28:32.002] .init = FALSE) [17:28:32.002] } [17:28:32.002] } [17:28:32.002] } [17:28:32.002] }) [17:28:32.002] if (TRUE) { [17:28:32.002] base::sink(type = "output", split = FALSE) [17:28:32.002] if (TRUE) { [17:28:32.002] ...future.result$stdout <- base::rawToChar(base::rawConnectionValue(...future.stdout)) [17:28:32.002] } [17:28:32.002] else { [17:28:32.002] ...future.result["stdout"] <- base::list(NULL) [17:28:32.002] } [17:28:32.002] base::close(...future.stdout) [17:28:32.002] ...future.stdout <- NULL [17:28:32.002] } [17:28:32.002] ...future.result$conditions <- ...future.conditions [17:28:32.002] ...future.result$finished <- base::Sys.time() [17:28:32.002] ...future.result [17:28:32.002] } [17:28:32.008] plan(): Setting new future strategy stack: [17:28:32.008] List of future strategies: [17:28:32.008] 1. sequential: [17:28:32.008] - args: function (..., envir = parent.frame(), workers = "") [17:28:32.008] - tweaked: FALSE [17:28:32.008] - call: NULL [17:28:32.009] plan(): nbrOfWorkers() = 1 [17:28:32.012] plan(): Setting new future strategy stack: [17:28:32.012] List of future strategies: [17:28:32.012] 1. multisession: [17:28:32.012] - args: function (..., workers = 1L, envir = parent.frame()) [17:28:32.012] - tweaked: TRUE [17:28:32.012] - call: plan(strategy, workers = 1L) [17:28:32.013] plan(): nbrOfWorkers() = 1 [17:28:32.014] SequentialFuture started (and completed) [17:28:32.014] plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... DONE [17:28:32.015] plan(): nbrOfWorkers() = 1 nbrOfWorkers: 1 [17:28:32.015] getGlobalsAndPackages() ... [17:28:32.016] Searching for globals... [17:28:32.019] [17:28:32.020] Searching for globals ... DONE [17:28:32.020] - globals: [0] [17:28:32.020] getGlobalsAndPackages() ... DONE nbrOfFreeWorkers: 1 [17:28:32.021] getGlobalsAndPackages() ... [17:28:32.021] Searching for globals... [17:28:32.022] [17:28:32.023] Searching for globals ... DONE [17:28:32.023] - globals: [0] [17:28:32.023] getGlobalsAndPackages() ... DONE nbrOfFreeWorkers(background = TRUE): 0 [17:28:32.025] plan(): Setting new future strategy stack: [17:28:32.026] List of future strategies: [17:28:32.026] 1. multisession: [17:28:32.026] - args: function (..., workers = "", envir = parent.frame()) [17:28:32.026] - tweaked: TRUE [17:28:32.026] - call: plan(strategy, workers = allButOneCore) [17:28:32.027] plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... [17:28:32.028] multisession: [17:28:32.028] - args: function (..., workers = "", envir = parent.frame()) [17:28:32.028] - tweaked: TRUE [17:28:32.028] - call: plan(strategy, workers = allButOneCore) [17:28:32.034] getGlobalsAndPackages() ... [17:28:32.035] Not searching for globals [17:28:32.035] - globals: [0] [17:28:32.035] getGlobalsAndPackages() ... DONE [17:28:32.037] Packages needed by the future expression (n = 0): [17:28:32.037] Packages needed by future strategies (n = 0): [17:28:32.039] { [17:28:32.039] { [17:28:32.039] { [17:28:32.039] ...future.startTime <- base::Sys.time() [17:28:32.039] { [17:28:32.039] { [17:28:32.039] { [17:28:32.039] base::local({ [17:28:32.039] has_future <- base::requireNamespace("future", [17:28:32.039] quietly = TRUE) [17:28:32.039] if (has_future) { [17:28:32.039] ns <- base::getNamespace("future") [17:28:32.039] version <- ns[[".package"]][["version"]] [17:28:32.039] if (is.null(version)) [17:28:32.039] version <- utils::packageVersion("future") [17:28:32.039] } [17:28:32.039] else { [17:28:32.039] version <- NULL [17:28:32.039] } [17:28:32.039] if (!has_future || version < "1.8.0") { [17:28:32.039] info <- base::c(r_version = base::gsub("R version ", [17:28:32.039] "", base::R.version$version.string), [17:28:32.039] platform = base::sprintf("%s (%s-bit)", [17:28:32.039] base::R.version$platform, 8 * base::.Machine$sizeof.pointer), [17:28:32.039] os = base::paste(base::Sys.info()[base::c("sysname", [17:28:32.039] "release", "version")], collapse = " "), [17:28:32.039] hostname = base::Sys.info()[["nodename"]]) [17:28:32.039] info <- base::sprintf("%s: %s", base::names(info), [17:28:32.039] info) [17:28:32.039] info <- base::paste(info, collapse = "; ") [17:28:32.039] if (!has_future) { [17:28:32.039] msg <- base::sprintf("Package 'future' is not installed on worker (%s)", [17:28:32.039] info) [17:28:32.039] } [17:28:32.039] else { [17:28:32.039] msg <- base::sprintf("Package 'future' on worker (%s) must be of version >= 1.8.0: %s", [17:28:32.039] info, version) [17:28:32.039] } [17:28:32.039] base::stop(msg) [17:28:32.039] } [17:28:32.039] }) [17:28:32.039] } [17:28:32.039] ...future.strategy.old <- future::plan("list") [17:28:32.039] options(future.plan = NULL) [17:28:32.039] Sys.unsetenv("R_FUTURE_PLAN") [17:28:32.039] future::plan("default", .cleanup = FALSE, .init = FALSE) [17:28:32.039] } [17:28:32.039] ...future.workdir <- getwd() [17:28:32.039] } [17:28:32.039] ...future.oldOptions <- base::as.list(base::.Options) [17:28:32.039] ...future.oldEnvVars <- base::Sys.getenv() [17:28:32.039] } [17:28:32.039] base::options(future.startup.script = FALSE, future.globals.onMissing = NULL, [17:28:32.039] future.globals.maxSize = NULL, future.globals.method = NULL, [17:28:32.039] future.globals.onMissing = NULL, future.globals.onReference = NULL, [17:28:32.039] future.globals.resolve = NULL, future.resolve.recursive = NULL, [17:28:32.039] future.rng.onMisuse = NULL, future.rng.onMisuse.keepFuture = NULL, [17:28:32.039] future.stdout.windows.reencode = NULL, width = 80L) [17:28:32.039] ...future.futureOptionsAdded <- base::setdiff(base::names(base::.Options), [17:28:32.039] base::names(...future.oldOptions)) [17:28:32.039] } [17:28:32.039] if (FALSE) { [17:28:32.039] } [17:28:32.039] else { [17:28:32.039] if (TRUE) { [17:28:32.039] ...future.stdout <- base::rawConnection(base::raw(0L), [17:28:32.039] open = "w") [17:28:32.039] } [17:28:32.039] else { [17:28:32.039] ...future.stdout <- base::file(base::switch(.Platform$OS.type, [17:28:32.039] windows = "NUL", "/dev/null"), open = "w") [17:28:32.039] } [17:28:32.039] base::sink(...future.stdout, type = "output", split = FALSE) [17:28:32.039] base::on.exit(if (!base::is.null(...future.stdout)) { [17:28:32.039] base::sink(type = "output", split = FALSE) [17:28:32.039] base::close(...future.stdout) [17:28:32.039] }, add = TRUE) [17:28:32.039] } [17:28:32.039] ...future.frame <- base::sys.nframe() [17:28:32.039] ...future.conditions <- base::list() [17:28:32.039] ...future.rng <- base::globalenv()$.Random.seed [17:28:32.039] if (FALSE) { [17:28:32.039] ...future.globalenv.names <- c(base::names(base::.GlobalEnv), [17:28:32.039] "...future.value", "...future.globalenv.names", ".Random.seed") [17:28:32.039] } [17:28:32.039] ...future.result <- base::tryCatch({ [17:28:32.039] base::withCallingHandlers({ [17:28:32.039] ...future.value <- base::withVisible(base::local(NA)) [17:28:32.039] future::FutureResult(value = ...future.value$value, [17:28:32.039] visible = ...future.value$visible, rng = !identical(base::globalenv()$.Random.seed, [17:28:32.039] ...future.rng), globalenv = if (FALSE) [17:28:32.039] list(added = base::setdiff(base::names(base::.GlobalEnv), [17:28:32.039] ...future.globalenv.names)) [17:28:32.039] else NULL, started = ...future.startTime, version = "1.8") [17:28:32.039] }, condition = base::local({ [17:28:32.039] c <- base::c [17:28:32.039] inherits <- base::inherits [17:28:32.039] invokeRestart <- base::invokeRestart [17:28:32.039] length <- base::length [17:28:32.039] list <- base::list [17:28:32.039] seq.int <- base::seq.int [17:28:32.039] signalCondition <- base::signalCondition [17:28:32.039] sys.calls <- base::sys.calls [17:28:32.039] `[[` <- base::`[[` [17:28:32.039] `+` <- base::`+` [17:28:32.039] `<<-` <- base::`<<-` [17:28:32.039] sysCalls <- function(calls = sys.calls(), from = 1L) { [17:28:32.039] calls[seq.int(from = from + 12L, to = length(calls) - [17:28:32.039] 3L)] [17:28:32.039] } [17:28:32.039] function(cond) { [17:28:32.039] is_error <- inherits(cond, "error") [17:28:32.039] ignore <- !is_error && !is.null(NULL) && inherits(cond, [17:28:32.039] NULL) [17:28:32.039] if (is_error) { [17:28:32.039] sessionInformation <- function() { [17:28:32.039] list(r = base::R.Version(), locale = base::Sys.getlocale(), [17:28:32.039] rngkind = base::RNGkind(), namespaces = base::loadedNamespaces(), [17:28:32.039] search = base::search(), system = base::Sys.info()) [17:28:32.039] } [17:28:32.039] ...future.conditions[[length(...future.conditions) + [17:28:32.039] 1L]] <<- list(condition = cond, calls = c(sysCalls(from = ...future.frame), [17:28:32.039] cond$call), session = sessionInformation(), [17:28:32.039] timestamp = base::Sys.time(), signaled = 0L) [17:28:32.039] signalCondition(cond) [17:28:32.039] } [17:28:32.039] else if (!ignore && TRUE && inherits(cond, c("condition", [17:28:32.039] "immediateCondition"))) { [17:28:32.039] signal <- TRUE && inherits(cond, "immediateCondition") [17:28:32.039] ...future.conditions[[length(...future.conditions) + [17:28:32.039] 1L]] <<- list(condition = cond, signaled = base::as.integer(signal)) [17:28:32.039] if (TRUE && !signal) { [17:28:32.039] muffleCondition <- function (cond, pattern = "^muffle") [17:28:32.039] { [17:28:32.039] inherits <- base::inherits [17:28:32.039] invokeRestart <- base::invokeRestart [17:28:32.039] is.null <- base::is.null [17:28:32.039] muffled <- FALSE [17:28:32.039] if (inherits(cond, "message")) { [17:28:32.039] muffled <- grepl(pattern, "muffleMessage") [17:28:32.039] if (muffled) [17:28:32.039] invokeRestart("muffleMessage") [17:28:32.039] } [17:28:32.039] else if (inherits(cond, "warning")) { [17:28:32.039] muffled <- grepl(pattern, "muffleWarning") [17:28:32.039] if (muffled) [17:28:32.039] invokeRestart("muffleWarning") [17:28:32.039] } [17:28:32.039] else if (inherits(cond, "condition")) { [17:28:32.039] if (!is.null(pattern)) { [17:28:32.039] computeRestarts <- base::computeRestarts [17:28:32.039] grepl <- base::grepl [17:28:32.039] restarts <- computeRestarts(cond) [17:28:32.039] for (restart in restarts) { [17:28:32.039] name <- restart$name [17:28:32.039] if (is.null(name)) [17:28:32.039] next [17:28:32.039] if (!grepl(pattern, name)) [17:28:32.039] next [17:28:32.039] invokeRestart(restart) [17:28:32.039] muffled <- TRUE [17:28:32.039] break [17:28:32.039] } [17:28:32.039] } [17:28:32.039] } [17:28:32.039] invisible(muffled) [17:28:32.039] } [17:28:32.039] muffleCondition(cond, pattern = "^muffle") [17:28:32.039] } [17:28:32.039] } [17:28:32.039] else { [17:28:32.039] if (TRUE) { [17:28:32.039] muffleCondition <- function (cond, pattern = "^muffle") [17:28:32.039] { [17:28:32.039] inherits <- base::inherits [17:28:32.039] invokeRestart <- base::invokeRestart [17:28:32.039] is.null <- base::is.null [17:28:32.039] muffled <- FALSE [17:28:32.039] if (inherits(cond, "message")) { [17:28:32.039] muffled <- grepl(pattern, "muffleMessage") [17:28:32.039] if (muffled) [17:28:32.039] invokeRestart("muffleMessage") [17:28:32.039] } [17:28:32.039] else if (inherits(cond, "warning")) { [17:28:32.039] muffled <- grepl(pattern, "muffleWarning") [17:28:32.039] if (muffled) [17:28:32.039] invokeRestart("muffleWarning") [17:28:32.039] } [17:28:32.039] else if (inherits(cond, "condition")) { [17:28:32.039] if (!is.null(pattern)) { [17:28:32.039] computeRestarts <- base::computeRestarts [17:28:32.039] grepl <- base::grepl [17:28:32.039] restarts <- computeRestarts(cond) [17:28:32.039] for (restart in restarts) { [17:28:32.039] name <- restart$name [17:28:32.039] if (is.null(name)) [17:28:32.039] next [17:28:32.039] if (!grepl(pattern, name)) [17:28:32.039] next [17:28:32.039] invokeRestart(restart) [17:28:32.039] muffled <- TRUE [17:28:32.039] break [17:28:32.039] } [17:28:32.039] } [17:28:32.039] } [17:28:32.039] invisible(muffled) [17:28:32.039] } [17:28:32.039] muffleCondition(cond, pattern = "^muffle") [17:28:32.039] } [17:28:32.039] } [17:28:32.039] } [17:28:32.039] })) [17:28:32.039] }, error = function(ex) { [17:28:32.039] base::structure(base::list(value = NULL, visible = NULL, [17:28:32.039] conditions = ...future.conditions, rng = !identical(base::globalenv()$.Random.seed, [17:28:32.039] ...future.rng), started = ...future.startTime, [17:28:32.039] finished = Sys.time(), session_uuid = NA_character_, [17:28:32.039] version = "1.8"), class = "FutureResult") [17:28:32.039] }, finally = { [17:28:32.039] if (!identical(...future.workdir, getwd())) [17:28:32.039] setwd(...future.workdir) [17:28:32.039] { [17:28:32.039] if (identical(getOption("nwarnings"), ...future.oldOptions$nwarnings)) { [17:28:32.039] ...future.oldOptions$nwarnings <- NULL [17:28:32.039] } [17:28:32.039] base::options(...future.oldOptions) [17:28:32.039] if (.Platform$OS.type == "windows") { [17:28:32.039] old_names <- names(...future.oldEnvVars) [17:28:32.039] envs <- base::Sys.getenv() [17:28:32.039] names <- names(envs) [17:28:32.039] common <- intersect(names, old_names) [17:28:32.039] added <- setdiff(names, old_names) [17:28:32.039] removed <- setdiff(old_names, names) [17:28:32.039] changed <- common[...future.oldEnvVars[common] != [17:28:32.039] envs[common]] [17:28:32.039] NAMES <- toupper(changed) [17:28:32.039] args <- list() [17:28:32.039] for (kk in seq_along(NAMES)) { [17:28:32.039] name <- changed[[kk]] [17:28:32.039] NAME <- NAMES[[kk]] [17:28:32.039] if (name != NAME && is.element(NAME, old_names)) [17:28:32.039] next [17:28:32.039] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:32.039] } [17:28:32.039] NAMES <- toupper(added) [17:28:32.039] for (kk in seq_along(NAMES)) { [17:28:32.039] name <- added[[kk]] [17:28:32.039] NAME <- NAMES[[kk]] [17:28:32.039] if (name != NAME && is.element(NAME, old_names)) [17:28:32.039] next [17:28:32.039] args[[name]] <- "" [17:28:32.039] } [17:28:32.039] NAMES <- toupper(removed) [17:28:32.039] for (kk in seq_along(NAMES)) { [17:28:32.039] name <- removed[[kk]] [17:28:32.039] NAME <- NAMES[[kk]] [17:28:32.039] if (name != NAME && is.element(NAME, old_names)) [17:28:32.039] next [17:28:32.039] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:32.039] } [17:28:32.039] if (length(args) > 0) [17:28:32.039] base::do.call(base::Sys.setenv, args = args) [17:28:32.039] args <- names <- old_names <- NAMES <- envs <- common <- added <- removed <- NULL [17:28:32.039] } [17:28:32.039] else { [17:28:32.039] base::do.call(base::Sys.setenv, args = base::as.list(...future.oldEnvVars)) [17:28:32.039] } [17:28:32.039] { [17:28:32.039] if (base::length(...future.futureOptionsAdded) > [17:28:32.039] 0L) { [17:28:32.039] opts <- base::vector("list", length = base::length(...future.futureOptionsAdded)) [17:28:32.039] base::names(opts) <- ...future.futureOptionsAdded [17:28:32.039] base::options(opts) [17:28:32.039] } [17:28:32.039] { [17:28:32.039] { [17:28:32.039] NULL [17:28:32.039] RNGkind("Mersenne-Twister") [17:28:32.039] base::rm(list = ".Random.seed", envir = base::globalenv(), [17:28:32.039] inherits = FALSE) [17:28:32.039] } [17:28:32.039] options(future.plan = NULL) [17:28:32.039] if (is.na(NA_character_)) [17:28:32.039] Sys.unsetenv("R_FUTURE_PLAN") [17:28:32.039] else Sys.setenv(R_FUTURE_PLAN = NA_character_) [17:28:32.039] future::plan(...future.strategy.old, .cleanup = FALSE, [17:28:32.039] .init = FALSE) [17:28:32.039] } [17:28:32.039] } [17:28:32.039] } [17:28:32.039] }) [17:28:32.039] if (TRUE) { [17:28:32.039] base::sink(type = "output", split = FALSE) [17:28:32.039] if (TRUE) { [17:28:32.039] ...future.result$stdout <- base::rawToChar(base::rawConnectionValue(...future.stdout)) [17:28:32.039] } [17:28:32.039] else { [17:28:32.039] ...future.result["stdout"] <- base::list(NULL) [17:28:32.039] } [17:28:32.039] base::close(...future.stdout) [17:28:32.039] ...future.stdout <- NULL [17:28:32.039] } [17:28:32.039] ...future.result$conditions <- ...future.conditions [17:28:32.039] ...future.result$finished <- base::Sys.time() [17:28:32.039] ...future.result [17:28:32.039] } [17:28:32.047] plan(): Setting new future strategy stack: [17:28:32.047] List of future strategies: [17:28:32.047] 1. sequential: [17:28:32.047] - args: function (..., envir = parent.frame(), workers = "") [17:28:32.047] - tweaked: FALSE [17:28:32.047] - call: NULL [17:28:32.049] plan(): nbrOfWorkers() = 1 [17:28:32.052] plan(): Setting new future strategy stack: [17:28:32.052] List of future strategies: [17:28:32.052] 1. multisession: [17:28:32.052] - args: function (..., workers = "", envir = parent.frame()) [17:28:32.052] - tweaked: TRUE [17:28:32.052] - call: plan(strategy, workers = allButOneCore) [17:28:32.066] plan(): nbrOfWorkers() = 1 [17:28:32.067] SequentialFuture started (and completed) [17:28:32.067] plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... DONE [17:28:32.069] plan(): nbrOfWorkers() = 1 nbrOfWorkers: 1 [17:28:32.076] getGlobalsAndPackages() ... [17:28:32.076] Searching for globals... [17:28:32.077] [17:28:32.077] Searching for globals ... DONE [17:28:32.077] - globals: [0] [17:28:32.077] getGlobalsAndPackages() ... DONE nbrOfFreeWorkers: 1 [17:28:32.082] getGlobalsAndPackages() ... [17:28:32.083] Searching for globals... [17:28:32.083] [17:28:32.083] Searching for globals ... DONE [17:28:32.083] - globals: [0] [17:28:32.084] getGlobalsAndPackages() ... DONE nbrOfFreeWorkers(background = TRUE): 0 > > > message("Type of future: cluster") Type of future: cluster > workers <- rep("localhost", times = 2L) > plan(cluster, workers = workers) [17:28:32.085] plan(): Setting new future strategy stack: [17:28:32.085] List of future strategies: [17:28:32.085] 1. cluster: [17:28:32.085] - args: function (..., workers = c("localhost", "localhost"), envir = parent.frame()) [17:28:32.085] - tweaked: TRUE [17:28:32.085] - call: plan(cluster, workers = workers) [17:28:32.085] plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... [17:28:32.086] cluster: [17:28:32.086] - args: function (..., workers = c("localhost", "localhost"), envir = parent.frame()) [17:28:32.086] - tweaked: TRUE [17:28:32.086] - call: plan(cluster, workers = workers) [17:28:32.086] getGlobalsAndPackages() ... [17:28:32.086] Not searching for globals [17:28:32.086] - globals: [0] [17:28:32.087] getGlobalsAndPackages() ... DONE [17:28:32.087] [local output] makeClusterPSOCK() ... [17:28:32.088] [local output] Workers: [n = 2] 'localhost', 'localhost' [17:28:32.091] [local output] Base port: 39445 [17:28:32.091] [local output] Getting setup options for 2 cluster nodes ... [17:28:32.091] [local output] - Node #1 of 2 ... [17:28:32.092] [local output] localMachine=TRUE => revtunnel=FALSE [17:28:32.093] [local output] Rscript port: 39445 [17:28:32.094] [local output] - Node #2 of 2 ... [17:28:32.094] [local output] localMachine=TRUE => revtunnel=FALSE [17:28:32.095] [local output] Rscript port: 39445 [17:28:32.096] [local output] Getting setup options for 2 cluster nodes ... done [17:28:32.096] [local output] - Parallel setup requested for some PSOCK nodes [17:28:32.096] [local output] Setting up PSOCK nodes in parallel [17:28:32.097] List of 36 [17:28:32.097] $ worker : chr "localhost" [17:28:32.097] ..- attr(*, "localhost")= logi TRUE [17:28:32.097] $ master : chr "localhost" [17:28:32.097] $ port : int 39445 [17:28:32.097] $ connectTimeout : num 120 [17:28:32.097] $ timeout : num 120 [17:28:32.097] $ rscript : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\"" [17:28:32.097] $ homogeneous : logi TRUE [17:28:32.097] $ rscript_args : chr "--default-packages=datasets,utils,grDevices,graphics,stats,methods -e \"#label=nbrOfWorkers.R:164204:CRANWIN3:C"| __truncated__ [17:28:32.097] $ rscript_envs : NULL [17:28:32.097] $ rscript_libs : NULL [17:28:32.097] $ rscript_startup : NULL [17:28:32.097] $ rscript_sh : chr [1:2] "cmd" "cmd" [17:28:32.097] $ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:32.097] $ methods : logi TRUE [17:28:32.097] $ socketOptions : chr "no-delay" [17:28:32.097] $ useXDR : logi FALSE [17:28:32.097] $ outfile : chr "/dev/null" [17:28:32.097] $ renice : int NA [17:28:32.097] $ rshcmd : NULL [17:28:32.097] $ user : chr(0) [17:28:32.097] $ revtunnel : logi FALSE [17:28:32.097] $ rshlogfile : NULL [17:28:32.097] $ rshopts : chr(0) [17:28:32.097] $ rank : int 1 [17:28:32.097] $ manual : logi FALSE [17:28:32.097] $ dryrun : logi FALSE [17:28:32.097] $ quiet : logi FALSE [17:28:32.097] $ setup_strategy : chr "parallel" [17:28:32.097] $ local_cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:32.097] $ pidfile : chr "D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c7885d59.pid" [17:28:32.097] $ rshcmd_label : NULL [17:28:32.097] $ rsh_call : NULL [17:28:32.097] $ cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:32.097] $ localMachine : logi TRUE [17:28:32.097] $ make_fcn :function (worker = getOption2("parallelly.localhost.hostname", "localhost"), [17:28:32.097] master = NULL, port, connectTimeout = getOption2("parallelly.makeNodePSOCK.connectTimeout", [17:28:32.097] 2 * 60), timeout = getOption2("parallelly.makeNodePSOCK.timeout", [17:28:32.097] 30 * 24 * 60 * 60), rscript = NULL, homogeneous = NULL, rscript_args = NULL, [17:28:32.097] rscript_envs = NULL, rscript_libs = NULL, rscript_startup = NULL, rscript_sh = c("auto", [17:28:32.097] "cmd", "sh", "none"), default_packages = c("datasets", "utils", [17:28:32.097] "grDevices", "graphics", "stats", if (methods) "methods"), methods = TRUE, [17:28:32.097] socketOptions = getOption2("parallelly.makeNodePSOCK.socketOptions", [17:28:32.097] "no-delay"), useXDR = getOption2("parallelly.makeNodePSOCK.useXDR", [17:28:32.097] FALSE), outfile = "/dev/null", renice = NA_integer_, rshcmd = getOption2("parallelly.makeNodePSOCK.rshcmd", [17:28:32.097] NULL), user = NULL, revtunnel = NA, rshlogfile = NULL, rshopts = getOption2("parallelly.makeNodePSOCK.rshopts", [17:28:32.097] NULL), rank = 1L, manual = FALSE, dryrun = FALSE, quiet = FALSE, [17:28:32.097] setup_strategy = getOption2("parallelly.makeNodePSOCK.setup_strategy", [17:28:32.097] "parallel"), action = c("launch", "options"), verbose = FALSE) [17:28:32.097] $ arguments :List of 28 [17:28:32.097] ..$ worker : chr "localhost" [17:28:32.097] ..$ master : NULL [17:28:32.097] ..$ port : int 39445 [17:28:32.097] ..$ connectTimeout : num 120 [17:28:32.097] ..$ timeout : num 120 [17:28:32.097] ..$ rscript : NULL [17:28:32.097] ..$ homogeneous : NULL [17:28:32.097] ..$ rscript_args : NULL [17:28:32.097] ..$ rscript_envs : NULL [17:28:32.097] ..$ rscript_libs : NULL [17:28:32.097] ..$ rscript_startup : NULL [17:28:32.097] ..$ rscript_sh : chr "auto" [17:28:32.097] ..$ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:32.097] ..$ methods : logi TRUE [17:28:32.097] ..$ socketOptions : chr "no-delay" [17:28:32.097] ..$ useXDR : logi FALSE [17:28:32.097] ..$ outfile : chr "/dev/null" [17:28:32.097] ..$ renice : int NA [17:28:32.097] ..$ rshcmd : NULL [17:28:32.097] ..$ user : NULL [17:28:32.097] ..$ revtunnel : logi NA [17:28:32.097] ..$ rshlogfile : NULL [17:28:32.097] ..$ rshopts : NULL [17:28:32.097] ..$ rank : int 1 [17:28:32.097] ..$ manual : logi FALSE [17:28:32.097] ..$ dryrun : logi FALSE [17:28:32.097] ..$ quiet : logi FALSE [17:28:32.097] ..$ setup_strategy : chr "parallel" [17:28:32.097] - attr(*, "class")= chr [1:2] "makeNodePSOCKOptions" "makeNodeOptions" [17:28:32.131] [local output] System call to launch all workers: [17:28:32.131] [local output] "D:/RCompile/recent/R/bin/x64/Rscript" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "#label=nbrOfWorkers.R:164204:CRANWIN3:CRAN" -e "try(suppressWarnings(cat(Sys.getpid(),file=\"D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c7885d59.pid\")), silent = TRUE)" -e "options(socketOptions = \"no-delay\")" -e "workRSOCK <- tryCatch(parallel:::.workRSOCK, error=function(e) parallel:::.slaveRSOCK); workRSOCK()" MASTER=localhost PORT=39445 OUT=/dev/null TIMEOUT=120 XDR=FALSE SETUPTIMEOUT=120 SETUPSTRATEGY=parallel [17:28:32.131] [local output] Starting PSOCK main server [17:28:32.141] [local output] Workers launched [17:28:32.142] [local output] Waiting for workers to connect back [17:28:32.142] - [local output] 0 workers out of 2 ready [17:28:32.408] - [local output] 0 workers out of 2 ready [17:28:32.409] - [local output] 1 workers out of 2 ready [17:28:32.417] - [local output] 1 workers out of 2 ready [17:28:32.418] - [local output] 2 workers out of 2 ready [17:28:32.418] [local output] Launching of 2 workers completed [17:28:32.418] [local output] Number of nodes in cluster: 2 [17:28:32.419] [local output] Collecting session information from 2 workers [17:28:32.420] [local output] - Worker #1 of 2 [17:28:32.421] [local output] - Worker #2 of 2 [17:28:32.421] [local output] makeClusterPSOCK() ... done [17:28:32.435] Packages needed by the future expression (n = 0): [17:28:32.435] Packages needed by future strategies (n = 0): [17:28:32.436] { [17:28:32.436] { [17:28:32.436] { [17:28:32.436] ...future.startTime <- base::Sys.time() [17:28:32.436] { [17:28:32.436] { [17:28:32.436] { [17:28:32.436] base::local({ [17:28:32.436] has_future <- base::requireNamespace("future", [17:28:32.436] quietly = TRUE) [17:28:32.436] if (has_future) { [17:28:32.436] ns <- base::getNamespace("future") [17:28:32.436] version <- ns[[".package"]][["version"]] [17:28:32.436] if (is.null(version)) [17:28:32.436] version <- utils::packageVersion("future") [17:28:32.436] } [17:28:32.436] else { [17:28:32.436] version <- NULL [17:28:32.436] } [17:28:32.436] if (!has_future || version < "1.8.0") { [17:28:32.436] info <- base::c(r_version = base::gsub("R version ", [17:28:32.436] "", base::R.version$version.string), [17:28:32.436] platform = base::sprintf("%s (%s-bit)", [17:28:32.436] base::R.version$platform, 8 * base::.Machine$sizeof.pointer), [17:28:32.436] os = base::paste(base::Sys.info()[base::c("sysname", [17:28:32.436] "release", "version")], collapse = " "), [17:28:32.436] hostname = base::Sys.info()[["nodename"]]) [17:28:32.436] info <- base::sprintf("%s: %s", base::names(info), [17:28:32.436] info) [17:28:32.436] info <- base::paste(info, collapse = "; ") [17:28:32.436] if (!has_future) { [17:28:32.436] msg <- base::sprintf("Package 'future' is not installed on worker (%s)", [17:28:32.436] info) [17:28:32.436] } [17:28:32.436] else { [17:28:32.436] msg <- base::sprintf("Package 'future' on worker (%s) must be of version >= 1.8.0: %s", [17:28:32.436] info, version) [17:28:32.436] } [17:28:32.436] base::stop(msg) [17:28:32.436] } [17:28:32.436] }) [17:28:32.436] } [17:28:32.436] ...future.strategy.old <- future::plan("list") [17:28:32.436] options(future.plan = NULL) [17:28:32.436] Sys.unsetenv("R_FUTURE_PLAN") [17:28:32.436] future::plan("default", .cleanup = FALSE, .init = FALSE) [17:28:32.436] } [17:28:32.436] ...future.workdir <- getwd() [17:28:32.436] } [17:28:32.436] ...future.oldOptions <- base::as.list(base::.Options) [17:28:32.436] ...future.oldEnvVars <- base::Sys.getenv() [17:28:32.436] } [17:28:32.436] base::options(future.startup.script = FALSE, future.globals.onMissing = NULL, [17:28:32.436] future.globals.maxSize = NULL, future.globals.method = NULL, [17:28:32.436] future.globals.onMissing = NULL, future.globals.onReference = NULL, [17:28:32.436] future.globals.resolve = NULL, future.resolve.recursive = NULL, [17:28:32.436] future.rng.onMisuse = NULL, future.rng.onMisuse.keepFuture = NULL, [17:28:32.436] future.stdout.windows.reencode = NULL, width = 80L) [17:28:32.436] ...future.futureOptionsAdded <- base::setdiff(base::names(base::.Options), [17:28:32.436] base::names(...future.oldOptions)) [17:28:32.436] } [17:28:32.436] if (FALSE) { [17:28:32.436] } [17:28:32.436] else { [17:28:32.436] if (TRUE) { [17:28:32.436] ...future.stdout <- base::rawConnection(base::raw(0L), [17:28:32.436] open = "w") [17:28:32.436] } [17:28:32.436] else { [17:28:32.436] ...future.stdout <- base::file(base::switch(.Platform$OS.type, [17:28:32.436] windows = "NUL", "/dev/null"), open = "w") [17:28:32.436] } [17:28:32.436] base::sink(...future.stdout, type = "output", split = FALSE) [17:28:32.436] base::on.exit(if (!base::is.null(...future.stdout)) { [17:28:32.436] base::sink(type = "output", split = FALSE) [17:28:32.436] base::close(...future.stdout) [17:28:32.436] }, add = TRUE) [17:28:32.436] } [17:28:32.436] ...future.frame <- base::sys.nframe() [17:28:32.436] ...future.conditions <- base::list() [17:28:32.436] ...future.rng <- base::globalenv()$.Random.seed [17:28:32.436] if (FALSE) { [17:28:32.436] ...future.globalenv.names <- c(base::names(base::.GlobalEnv), [17:28:32.436] "...future.value", "...future.globalenv.names", ".Random.seed") [17:28:32.436] } [17:28:32.436] ...future.result <- base::tryCatch({ [17:28:32.436] base::withCallingHandlers({ [17:28:32.436] ...future.value <- base::withVisible(base::local({ [17:28:32.436] ...future.makeSendCondition <- base::local({ [17:28:32.436] sendCondition <- NULL [17:28:32.436] function(frame = 1L) { [17:28:32.436] if (is.function(sendCondition)) [17:28:32.436] return(sendCondition) [17:28:32.436] ns <- getNamespace("parallel") [17:28:32.436] if (exists("sendData", mode = "function", [17:28:32.436] envir = ns)) { [17:28:32.436] parallel_sendData <- get("sendData", mode = "function", [17:28:32.436] envir = ns) [17:28:32.436] envir <- sys.frame(frame) [17:28:32.436] master <- NULL [17:28:32.436] while (!identical(envir, .GlobalEnv) && [17:28:32.436] !identical(envir, emptyenv())) { [17:28:32.436] if (exists("master", mode = "list", envir = envir, [17:28:32.436] inherits = FALSE)) { [17:28:32.436] master <- get("master", mode = "list", [17:28:32.436] envir = envir, inherits = FALSE) [17:28:32.436] if (inherits(master, c("SOCKnode", [17:28:32.436] "SOCK0node"))) { [17:28:32.436] sendCondition <<- function(cond) { [17:28:32.436] data <- list(type = "VALUE", value = cond, [17:28:32.436] success = TRUE) [17:28:32.436] parallel_sendData(master, data) [17:28:32.436] } [17:28:32.436] return(sendCondition) [17:28:32.436] } [17:28:32.436] } [17:28:32.436] frame <- frame + 1L [17:28:32.436] envir <- sys.frame(frame) [17:28:32.436] } [17:28:32.436] } [17:28:32.436] sendCondition <<- function(cond) NULL [17:28:32.436] } [17:28:32.436] }) [17:28:32.436] withCallingHandlers({ [17:28:32.436] NA [17:28:32.436] }, immediateCondition = function(cond) { [17:28:32.436] sendCondition <- ...future.makeSendCondition() [17:28:32.436] sendCondition(cond) [17:28:32.436] muffleCondition <- function (cond, pattern = "^muffle") [17:28:32.436] { [17:28:32.436] inherits <- base::inherits [17:28:32.436] invokeRestart <- base::invokeRestart [17:28:32.436] is.null <- base::is.null [17:28:32.436] muffled <- FALSE [17:28:32.436] if (inherits(cond, "message")) { [17:28:32.436] muffled <- grepl(pattern, "muffleMessage") [17:28:32.436] if (muffled) [17:28:32.436] invokeRestart("muffleMessage") [17:28:32.436] } [17:28:32.436] else if (inherits(cond, "warning")) { [17:28:32.436] muffled <- grepl(pattern, "muffleWarning") [17:28:32.436] if (muffled) [17:28:32.436] invokeRestart("muffleWarning") [17:28:32.436] } [17:28:32.436] else if (inherits(cond, "condition")) { [17:28:32.436] if (!is.null(pattern)) { [17:28:32.436] computeRestarts <- base::computeRestarts [17:28:32.436] grepl <- base::grepl [17:28:32.436] restarts <- computeRestarts(cond) [17:28:32.436] for (restart in restarts) { [17:28:32.436] name <- restart$name [17:28:32.436] if (is.null(name)) [17:28:32.436] next [17:28:32.436] if (!grepl(pattern, name)) [17:28:32.436] next [17:28:32.436] invokeRestart(restart) [17:28:32.436] muffled <- TRUE [17:28:32.436] break [17:28:32.436] } [17:28:32.436] } [17:28:32.436] } [17:28:32.436] invisible(muffled) [17:28:32.436] } [17:28:32.436] muffleCondition(cond) [17:28:32.436] }) [17:28:32.436] })) [17:28:32.436] future::FutureResult(value = ...future.value$value, [17:28:32.436] visible = ...future.value$visible, rng = !identical(base::globalenv()$.Random.seed, [17:28:32.436] ...future.rng), globalenv = if (FALSE) [17:28:32.436] list(added = base::setdiff(base::names(base::.GlobalEnv), [17:28:32.436] ...future.globalenv.names)) [17:28:32.436] else NULL, started = ...future.startTime, version = "1.8") [17:28:32.436] }, condition = base::local({ [17:28:32.436] c <- base::c [17:28:32.436] inherits <- base::inherits [17:28:32.436] invokeRestart <- base::invokeRestart [17:28:32.436] length <- base::length [17:28:32.436] list <- base::list [17:28:32.436] seq.int <- base::seq.int [17:28:32.436] signalCondition <- base::signalCondition [17:28:32.436] sys.calls <- base::sys.calls [17:28:32.436] `[[` <- base::`[[` [17:28:32.436] `+` <- base::`+` [17:28:32.436] `<<-` <- base::`<<-` [17:28:32.436] sysCalls <- function(calls = sys.calls(), from = 1L) { [17:28:32.436] calls[seq.int(from = from + 12L, to = length(calls) - [17:28:32.436] 3L)] [17:28:32.436] } [17:28:32.436] function(cond) { [17:28:32.436] is_error <- inherits(cond, "error") [17:28:32.436] ignore <- !is_error && !is.null(NULL) && inherits(cond, [17:28:32.436] NULL) [17:28:32.436] if (is_error) { [17:28:32.436] sessionInformation <- function() { [17:28:32.436] list(r = base::R.Version(), locale = base::Sys.getlocale(), [17:28:32.436] rngkind = base::RNGkind(), namespaces = base::loadedNamespaces(), [17:28:32.436] search = base::search(), system = base::Sys.info()) [17:28:32.436] } [17:28:32.436] ...future.conditions[[length(...future.conditions) + [17:28:32.436] 1L]] <<- list(condition = cond, calls = c(sysCalls(from = ...future.frame), [17:28:32.436] cond$call), session = sessionInformation(), [17:28:32.436] timestamp = base::Sys.time(), signaled = 0L) [17:28:32.436] signalCondition(cond) [17:28:32.436] } [17:28:32.436] else if (!ignore && TRUE && inherits(cond, c("condition", [17:28:32.436] "immediateCondition"))) { [17:28:32.436] signal <- TRUE && inherits(cond, "immediateCondition") [17:28:32.436] ...future.conditions[[length(...future.conditions) + [17:28:32.436] 1L]] <<- list(condition = cond, signaled = base::as.integer(signal)) [17:28:32.436] if (TRUE && !signal) { [17:28:32.436] muffleCondition <- function (cond, pattern = "^muffle") [17:28:32.436] { [17:28:32.436] inherits <- base::inherits [17:28:32.436] invokeRestart <- base::invokeRestart [17:28:32.436] is.null <- base::is.null [17:28:32.436] muffled <- FALSE [17:28:32.436] if (inherits(cond, "message")) { [17:28:32.436] muffled <- grepl(pattern, "muffleMessage") [17:28:32.436] if (muffled) [17:28:32.436] invokeRestart("muffleMessage") [17:28:32.436] } [17:28:32.436] else if (inherits(cond, "warning")) { [17:28:32.436] muffled <- grepl(pattern, "muffleWarning") [17:28:32.436] if (muffled) [17:28:32.436] invokeRestart("muffleWarning") [17:28:32.436] } [17:28:32.436] else if (inherits(cond, "condition")) { [17:28:32.436] if (!is.null(pattern)) { [17:28:32.436] computeRestarts <- base::computeRestarts [17:28:32.436] grepl <- base::grepl [17:28:32.436] restarts <- computeRestarts(cond) [17:28:32.436] for (restart in restarts) { [17:28:32.436] name <- restart$name [17:28:32.436] if (is.null(name)) [17:28:32.436] next [17:28:32.436] if (!grepl(pattern, name)) [17:28:32.436] next [17:28:32.436] invokeRestart(restart) [17:28:32.436] muffled <- TRUE [17:28:32.436] break [17:28:32.436] } [17:28:32.436] } [17:28:32.436] } [17:28:32.436] invisible(muffled) [17:28:32.436] } [17:28:32.436] muffleCondition(cond, pattern = "^muffle") [17:28:32.436] } [17:28:32.436] } [17:28:32.436] else { [17:28:32.436] if (TRUE) { [17:28:32.436] muffleCondition <- function (cond, pattern = "^muffle") [17:28:32.436] { [17:28:32.436] inherits <- base::inherits [17:28:32.436] invokeRestart <- base::invokeRestart [17:28:32.436] is.null <- base::is.null [17:28:32.436] muffled <- FALSE [17:28:32.436] if (inherits(cond, "message")) { [17:28:32.436] muffled <- grepl(pattern, "muffleMessage") [17:28:32.436] if (muffled) [17:28:32.436] invokeRestart("muffleMessage") [17:28:32.436] } [17:28:32.436] else if (inherits(cond, "warning")) { [17:28:32.436] muffled <- grepl(pattern, "muffleWarning") [17:28:32.436] if (muffled) [17:28:32.436] invokeRestart("muffleWarning") [17:28:32.436] } [17:28:32.436] else if (inherits(cond, "condition")) { [17:28:32.436] if (!is.null(pattern)) { [17:28:32.436] computeRestarts <- base::computeRestarts [17:28:32.436] grepl <- base::grepl [17:28:32.436] restarts <- computeRestarts(cond) [17:28:32.436] for (restart in restarts) { [17:28:32.436] name <- restart$name [17:28:32.436] if (is.null(name)) [17:28:32.436] next [17:28:32.436] if (!grepl(pattern, name)) [17:28:32.436] next [17:28:32.436] invokeRestart(restart) [17:28:32.436] muffled <- TRUE [17:28:32.436] break [17:28:32.436] } [17:28:32.436] } [17:28:32.436] } [17:28:32.436] invisible(muffled) [17:28:32.436] } [17:28:32.436] muffleCondition(cond, pattern = "^muffle") [17:28:32.436] } [17:28:32.436] } [17:28:32.436] } [17:28:32.436] })) [17:28:32.436] }, error = function(ex) { [17:28:32.436] base::structure(base::list(value = NULL, visible = NULL, [17:28:32.436] conditions = ...future.conditions, rng = !identical(base::globalenv()$.Random.seed, [17:28:32.436] ...future.rng), started = ...future.startTime, [17:28:32.436] finished = Sys.time(), session_uuid = NA_character_, [17:28:32.436] version = "1.8"), class = "FutureResult") [17:28:32.436] }, finally = { [17:28:32.436] if (!identical(...future.workdir, getwd())) [17:28:32.436] setwd(...future.workdir) [17:28:32.436] { [17:28:32.436] if (identical(getOption("nwarnings"), ...future.oldOptions$nwarnings)) { [17:28:32.436] ...future.oldOptions$nwarnings <- NULL [17:28:32.436] } [17:28:32.436] base::options(...future.oldOptions) [17:28:32.436] if (.Platform$OS.type == "windows") { [17:28:32.436] old_names <- names(...future.oldEnvVars) [17:28:32.436] envs <- base::Sys.getenv() [17:28:32.436] names <- names(envs) [17:28:32.436] common <- intersect(names, old_names) [17:28:32.436] added <- setdiff(names, old_names) [17:28:32.436] removed <- setdiff(old_names, names) [17:28:32.436] changed <- common[...future.oldEnvVars[common] != [17:28:32.436] envs[common]] [17:28:32.436] NAMES <- toupper(changed) [17:28:32.436] args <- list() [17:28:32.436] for (kk in seq_along(NAMES)) { [17:28:32.436] name <- changed[[kk]] [17:28:32.436] NAME <- NAMES[[kk]] [17:28:32.436] if (name != NAME && is.element(NAME, old_names)) [17:28:32.436] next [17:28:32.436] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:32.436] } [17:28:32.436] NAMES <- toupper(added) [17:28:32.436] for (kk in seq_along(NAMES)) { [17:28:32.436] name <- added[[kk]] [17:28:32.436] NAME <- NAMES[[kk]] [17:28:32.436] if (name != NAME && is.element(NAME, old_names)) [17:28:32.436] next [17:28:32.436] args[[name]] <- "" [17:28:32.436] } [17:28:32.436] NAMES <- toupper(removed) [17:28:32.436] for (kk in seq_along(NAMES)) { [17:28:32.436] name <- removed[[kk]] [17:28:32.436] NAME <- NAMES[[kk]] [17:28:32.436] if (name != NAME && is.element(NAME, old_names)) [17:28:32.436] next [17:28:32.436] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:32.436] } [17:28:32.436] if (length(args) > 0) [17:28:32.436] base::do.call(base::Sys.setenv, args = args) [17:28:32.436] args <- names <- old_names <- NAMES <- envs <- common <- added <- removed <- NULL [17:28:32.436] } [17:28:32.436] else { [17:28:32.436] base::do.call(base::Sys.setenv, args = base::as.list(...future.oldEnvVars)) [17:28:32.436] } [17:28:32.436] { [17:28:32.436] if (base::length(...future.futureOptionsAdded) > [17:28:32.436] 0L) { [17:28:32.436] opts <- base::vector("list", length = base::length(...future.futureOptionsAdded)) [17:28:32.436] base::names(opts) <- ...future.futureOptionsAdded [17:28:32.436] base::options(opts) [17:28:32.436] } [17:28:32.436] { [17:28:32.436] NULL [17:28:32.436] options(future.plan = NULL) [17:28:32.436] if (is.na(NA_character_)) [17:28:32.436] Sys.unsetenv("R_FUTURE_PLAN") [17:28:32.436] else Sys.setenv(R_FUTURE_PLAN = NA_character_) [17:28:32.436] future::plan(...future.strategy.old, .cleanup = FALSE, [17:28:32.436] .init = FALSE) [17:28:32.436] } [17:28:32.436] } [17:28:32.436] } [17:28:32.436] }) [17:28:32.436] if (TRUE) { [17:28:32.436] base::sink(type = "output", split = FALSE) [17:28:32.436] if (TRUE) { [17:28:32.436] ...future.result$stdout <- base::rawToChar(base::rawConnectionValue(...future.stdout)) [17:28:32.436] } [17:28:32.436] else { [17:28:32.436] ...future.result["stdout"] <- base::list(NULL) [17:28:32.436] } [17:28:32.436] base::close(...future.stdout) [17:28:32.436] ...future.stdout <- NULL [17:28:32.436] } [17:28:32.436] ...future.result$conditions <- ...future.conditions [17:28:32.436] ...future.result$finished <- base::Sys.time() [17:28:32.436] ...future.result [17:28:32.436] } [17:28:32.584] ClusterFuture started [17:28:32.584] result() for ClusterFuture ... [17:28:32.584] receiveMessageFromWorker() for ClusterFuture ... [17:28:32.584] - Validating connection of ClusterFuture [17:28:32.661] - received message: FutureResult [17:28:32.661] - Received FutureResult [17:28:32.661] - Erased future from FutureRegistry [17:28:32.662] result() for ClusterFuture ... [17:28:32.662] - result already collected: FutureResult [17:28:32.662] result() for ClusterFuture ... done [17:28:32.663] receiveMessageFromWorker() for ClusterFuture ... done [17:28:32.663] result() for ClusterFuture ... done [17:28:32.663] result() for ClusterFuture ... [17:28:32.664] - result already collected: FutureResult [17:28:32.664] result() for ClusterFuture ... done [17:28:32.664] plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... DONE [17:28:32.664] plan(): nbrOfWorkers() = 2 > n <- nbrOfWorkers() > message(sprintf("nbrOfWorkers: %d", n)) nbrOfWorkers: 2 > stopifnot(n == length(workers)) > plan(cluster, workers = allButOneWorker) [17:28:32.665] plan(): Setting new future strategy stack: [17:28:32.665] List of future strategies: [17:28:32.665] 1. cluster: [17:28:32.665] - args: function (..., workers = "", envir = parent.frame()) [17:28:32.665] - tweaked: TRUE [17:28:32.665] - call: plan(cluster, workers = allButOneWorker) [17:28:32.676] plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... [17:28:32.676] cluster: [17:28:32.676] - args: function (..., workers = "", envir = parent.frame()) [17:28:32.676] - tweaked: TRUE [17:28:32.676] - call: plan(cluster, workers = allButOneWorker) [17:28:32.678] getGlobalsAndPackages() ... [17:28:32.678] Not searching for globals [17:28:32.679] - globals: [0] [17:28:32.679] getGlobalsAndPackages() ... DONE [17:28:32.685] [local output] makeClusterPSOCK() ... [17:28:32.686] [local output] Workers: [n = 1] 'localhost' [17:28:32.689] [local output] Base port: 30017 [17:28:32.689] [local output] Getting setup options for 1 cluster nodes ... [17:28:32.690] [local output] - Node #1 of 1 ... [17:28:32.690] [local output] localMachine=TRUE => revtunnel=FALSE [17:28:32.692] [local output] Rscript port: 30017 [17:28:32.693] [local output] Getting setup options for 1 cluster nodes ... done [17:28:32.693] [local output] - Parallel setup requested for some PSOCK nodes [17:28:32.694] [local output] Setting up PSOCK nodes in parallel [17:28:32.694] List of 36 [17:28:32.694] $ worker : chr "localhost" [17:28:32.694] ..- attr(*, "localhost")= logi TRUE [17:28:32.694] $ master : chr "localhost" [17:28:32.694] $ port : int 30017 [17:28:32.694] $ connectTimeout : num 120 [17:28:32.694] $ timeout : num 120 [17:28:32.694] $ rscript : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\"" [17:28:32.694] $ homogeneous : logi TRUE [17:28:32.694] $ rscript_args : chr "--default-packages=datasets,utils,grDevices,graphics,stats,methods -e \"#label=nbrOfWorkers.R:164204:CRANWIN3:C"| __truncated__ [17:28:32.694] $ rscript_envs : NULL [17:28:32.694] $ rscript_libs : NULL [17:28:32.694] $ rscript_startup : NULL [17:28:32.694] $ rscript_sh : chr [1:2] "cmd" "cmd" [17:28:32.694] $ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:32.694] $ methods : logi TRUE [17:28:32.694] $ socketOptions : chr "no-delay" [17:28:32.694] $ useXDR : logi FALSE [17:28:32.694] $ outfile : chr "/dev/null" [17:28:32.694] $ renice : int NA [17:28:32.694] $ rshcmd : NULL [17:28:32.694] $ user : chr(0) [17:28:32.694] $ revtunnel : logi FALSE [17:28:32.694] $ rshlogfile : NULL [17:28:32.694] $ rshopts : chr(0) [17:28:32.694] $ rank : int 1 [17:28:32.694] $ manual : logi FALSE [17:28:32.694] $ dryrun : logi FALSE [17:28:32.694] $ quiet : logi FALSE [17:28:32.694] $ setup_strategy : chr "parallel" [17:28:32.694] $ local_cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:32.694] $ pidfile : chr "D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c7bb27ab.pid" [17:28:32.694] $ rshcmd_label : NULL [17:28:32.694] $ rsh_call : NULL [17:28:32.694] $ cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:32.694] $ localMachine : logi TRUE [17:28:32.694] $ make_fcn :function (worker = getOption2("parallelly.localhost.hostname", "localhost"), [17:28:32.694] master = NULL, port, connectTimeout = getOption2("parallelly.makeNodePSOCK.connectTimeout", [17:28:32.694] 2 * 60), timeout = getOption2("parallelly.makeNodePSOCK.timeout", [17:28:32.694] 30 * 24 * 60 * 60), rscript = NULL, homogeneous = NULL, rscript_args = NULL, [17:28:32.694] rscript_envs = NULL, rscript_libs = NULL, rscript_startup = NULL, rscript_sh = c("auto", [17:28:32.694] "cmd", "sh", "none"), default_packages = c("datasets", "utils", [17:28:32.694] "grDevices", "graphics", "stats", if (methods) "methods"), methods = TRUE, [17:28:32.694] socketOptions = getOption2("parallelly.makeNodePSOCK.socketOptions", [17:28:32.694] "no-delay"), useXDR = getOption2("parallelly.makeNodePSOCK.useXDR", [17:28:32.694] FALSE), outfile = "/dev/null", renice = NA_integer_, rshcmd = getOption2("parallelly.makeNodePSOCK.rshcmd", [17:28:32.694] NULL), user = NULL, revtunnel = NA, rshlogfile = NULL, rshopts = getOption2("parallelly.makeNodePSOCK.rshopts", [17:28:32.694] NULL), rank = 1L, manual = FALSE, dryrun = FALSE, quiet = FALSE, [17:28:32.694] setup_strategy = getOption2("parallelly.makeNodePSOCK.setup_strategy", [17:28:32.694] "parallel"), action = c("launch", "options"), verbose = FALSE) [17:28:32.694] $ arguments :List of 28 [17:28:32.694] ..$ worker : chr "localhost" [17:28:32.694] ..$ master : NULL [17:28:32.694] ..$ port : int 30017 [17:28:32.694] ..$ connectTimeout : num 120 [17:28:32.694] ..$ timeout : num 120 [17:28:32.694] ..$ rscript : NULL [17:28:32.694] ..$ homogeneous : NULL [17:28:32.694] ..$ rscript_args : NULL [17:28:32.694] ..$ rscript_envs : NULL [17:28:32.694] ..$ rscript_libs : NULL [17:28:32.694] ..$ rscript_startup : NULL [17:28:32.694] ..$ rscript_sh : chr "auto" [17:28:32.694] ..$ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:32.694] ..$ methods : logi TRUE [17:28:32.694] ..$ socketOptions : chr "no-delay" [17:28:32.694] ..$ useXDR : logi FALSE [17:28:32.694] ..$ outfile : chr "/dev/null" [17:28:32.694] ..$ renice : int NA [17:28:32.694] ..$ rshcmd : NULL [17:28:32.694] ..$ user : NULL [17:28:32.694] ..$ revtunnel : logi NA [17:28:32.694] ..$ rshlogfile : NULL [17:28:32.694] ..$ rshopts : NULL [17:28:32.694] ..$ rank : int 1 [17:28:32.694] ..$ manual : logi FALSE [17:28:32.694] ..$ dryrun : logi FALSE [17:28:32.694] ..$ quiet : logi FALSE [17:28:32.694] ..$ setup_strategy : chr "parallel" [17:28:32.694] - attr(*, "class")= chr [1:2] "makeNodePSOCKOptions" "makeNodeOptions" [17:28:32.731] [local output] System call to launch all workers: [17:28:32.732] [local output] "D:/RCompile/recent/R/bin/x64/Rscript" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "#label=nbrOfWorkers.R:164204:CRANWIN3:CRAN" -e "try(suppressWarnings(cat(Sys.getpid(),file=\"D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c7bb27ab.pid\")), silent = TRUE)" -e "options(socketOptions = \"no-delay\")" -e "workRSOCK <- tryCatch(parallel:::.workRSOCK, error=function(e) parallel:::.slaveRSOCK); workRSOCK()" MASTER=localhost PORT=30017 OUT=/dev/null TIMEOUT=120 XDR=FALSE SETUPTIMEOUT=120 SETUPSTRATEGY=parallel [17:28:32.732] [local output] Starting PSOCK main server [17:28:32.738] [local output] Workers launched [17:28:32.739] [local output] Waiting for workers to connect back [17:28:32.739] - [local output] 0 workers out of 1 ready [17:28:33.005] - [local output] 0 workers out of 1 ready [17:28:33.005] - [local output] 1 workers out of 1 ready [17:28:33.006] [local output] Launching of 1 workers completed [17:28:33.006] [local output] Number of nodes in cluster: 1 [17:28:33.006] [local output] Collecting session information from 1 workers [17:28:33.007] [local output] - Worker #1 of 1 [17:28:33.008] [local output] makeClusterPSOCK() ... done [17:28:33.016] Packages needed by the future expression (n = 0): [17:28:33.016] Packages needed by future strategies (n = 0): [17:28:33.017] { [17:28:33.017] { [17:28:33.017] { [17:28:33.017] ...future.startTime <- base::Sys.time() [17:28:33.017] { [17:28:33.017] { [17:28:33.017] { [17:28:33.017] base::local({ [17:28:33.017] has_future <- base::requireNamespace("future", [17:28:33.017] quietly = TRUE) [17:28:33.017] if (has_future) { [17:28:33.017] ns <- base::getNamespace("future") [17:28:33.017] version <- ns[[".package"]][["version"]] [17:28:33.017] if (is.null(version)) [17:28:33.017] version <- utils::packageVersion("future") [17:28:33.017] } [17:28:33.017] else { [17:28:33.017] version <- NULL [17:28:33.017] } [17:28:33.017] if (!has_future || version < "1.8.0") { [17:28:33.017] info <- base::c(r_version = base::gsub("R version ", [17:28:33.017] "", base::R.version$version.string), [17:28:33.017] platform = base::sprintf("%s (%s-bit)", [17:28:33.017] base::R.version$platform, 8 * base::.Machine$sizeof.pointer), [17:28:33.017] os = base::paste(base::Sys.info()[base::c("sysname", [17:28:33.017] "release", "version")], collapse = " "), [17:28:33.017] hostname = base::Sys.info()[["nodename"]]) [17:28:33.017] info <- base::sprintf("%s: %s", base::names(info), [17:28:33.017] info) [17:28:33.017] info <- base::paste(info, collapse = "; ") [17:28:33.017] if (!has_future) { [17:28:33.017] msg <- base::sprintf("Package 'future' is not installed on worker (%s)", [17:28:33.017] info) [17:28:33.017] } [17:28:33.017] else { [17:28:33.017] msg <- base::sprintf("Package 'future' on worker (%s) must be of version >= 1.8.0: %s", [17:28:33.017] info, version) [17:28:33.017] } [17:28:33.017] base::stop(msg) [17:28:33.017] } [17:28:33.017] }) [17:28:33.017] } [17:28:33.017] ...future.strategy.old <- future::plan("list") [17:28:33.017] options(future.plan = NULL) [17:28:33.017] Sys.unsetenv("R_FUTURE_PLAN") [17:28:33.017] future::plan("default", .cleanup = FALSE, .init = FALSE) [17:28:33.017] } [17:28:33.017] ...future.workdir <- getwd() [17:28:33.017] } [17:28:33.017] ...future.oldOptions <- base::as.list(base::.Options) [17:28:33.017] ...future.oldEnvVars <- base::Sys.getenv() [17:28:33.017] } [17:28:33.017] base::options(future.startup.script = FALSE, future.globals.onMissing = NULL, [17:28:33.017] future.globals.maxSize = NULL, future.globals.method = NULL, [17:28:33.017] future.globals.onMissing = NULL, future.globals.onReference = NULL, [17:28:33.017] future.globals.resolve = NULL, future.resolve.recursive = NULL, [17:28:33.017] future.rng.onMisuse = NULL, future.rng.onMisuse.keepFuture = NULL, [17:28:33.017] future.stdout.windows.reencode = NULL, width = 80L) [17:28:33.017] ...future.futureOptionsAdded <- base::setdiff(base::names(base::.Options), [17:28:33.017] base::names(...future.oldOptions)) [17:28:33.017] } [17:28:33.017] if (FALSE) { [17:28:33.017] } [17:28:33.017] else { [17:28:33.017] if (TRUE) { [17:28:33.017] ...future.stdout <- base::rawConnection(base::raw(0L), [17:28:33.017] open = "w") [17:28:33.017] } [17:28:33.017] else { [17:28:33.017] ...future.stdout <- base::file(base::switch(.Platform$OS.type, [17:28:33.017] windows = "NUL", "/dev/null"), open = "w") [17:28:33.017] } [17:28:33.017] base::sink(...future.stdout, type = "output", split = FALSE) [17:28:33.017] base::on.exit(if (!base::is.null(...future.stdout)) { [17:28:33.017] base::sink(type = "output", split = FALSE) [17:28:33.017] base::close(...future.stdout) [17:28:33.017] }, add = TRUE) [17:28:33.017] } [17:28:33.017] ...future.frame <- base::sys.nframe() [17:28:33.017] ...future.conditions <- base::list() [17:28:33.017] ...future.rng <- base::globalenv()$.Random.seed [17:28:33.017] if (FALSE) { [17:28:33.017] ...future.globalenv.names <- c(base::names(base::.GlobalEnv), [17:28:33.017] "...future.value", "...future.globalenv.names", ".Random.seed") [17:28:33.017] } [17:28:33.017] ...future.result <- base::tryCatch({ [17:28:33.017] base::withCallingHandlers({ [17:28:33.017] ...future.value <- base::withVisible(base::local({ [17:28:33.017] ...future.makeSendCondition <- base::local({ [17:28:33.017] sendCondition <- NULL [17:28:33.017] function(frame = 1L) { [17:28:33.017] if (is.function(sendCondition)) [17:28:33.017] return(sendCondition) [17:28:33.017] ns <- getNamespace("parallel") [17:28:33.017] if (exists("sendData", mode = "function", [17:28:33.017] envir = ns)) { [17:28:33.017] parallel_sendData <- get("sendData", mode = "function", [17:28:33.017] envir = ns) [17:28:33.017] envir <- sys.frame(frame) [17:28:33.017] master <- NULL [17:28:33.017] while (!identical(envir, .GlobalEnv) && [17:28:33.017] !identical(envir, emptyenv())) { [17:28:33.017] if (exists("master", mode = "list", envir = envir, [17:28:33.017] inherits = FALSE)) { [17:28:33.017] master <- get("master", mode = "list", [17:28:33.017] envir = envir, inherits = FALSE) [17:28:33.017] if (inherits(master, c("SOCKnode", [17:28:33.017] "SOCK0node"))) { [17:28:33.017] sendCondition <<- function(cond) { [17:28:33.017] data <- list(type = "VALUE", value = cond, [17:28:33.017] success = TRUE) [17:28:33.017] parallel_sendData(master, data) [17:28:33.017] } [17:28:33.017] return(sendCondition) [17:28:33.017] } [17:28:33.017] } [17:28:33.017] frame <- frame + 1L [17:28:33.017] envir <- sys.frame(frame) [17:28:33.017] } [17:28:33.017] } [17:28:33.017] sendCondition <<- function(cond) NULL [17:28:33.017] } [17:28:33.017] }) [17:28:33.017] withCallingHandlers({ [17:28:33.017] NA [17:28:33.017] }, immediateCondition = function(cond) { [17:28:33.017] sendCondition <- ...future.makeSendCondition() [17:28:33.017] sendCondition(cond) [17:28:33.017] muffleCondition <- function (cond, pattern = "^muffle") [17:28:33.017] { [17:28:33.017] inherits <- base::inherits [17:28:33.017] invokeRestart <- base::invokeRestart [17:28:33.017] is.null <- base::is.null [17:28:33.017] muffled <- FALSE [17:28:33.017] if (inherits(cond, "message")) { [17:28:33.017] muffled <- grepl(pattern, "muffleMessage") [17:28:33.017] if (muffled) [17:28:33.017] invokeRestart("muffleMessage") [17:28:33.017] } [17:28:33.017] else if (inherits(cond, "warning")) { [17:28:33.017] muffled <- grepl(pattern, "muffleWarning") [17:28:33.017] if (muffled) [17:28:33.017] invokeRestart("muffleWarning") [17:28:33.017] } [17:28:33.017] else if (inherits(cond, "condition")) { [17:28:33.017] if (!is.null(pattern)) { [17:28:33.017] computeRestarts <- base::computeRestarts [17:28:33.017] grepl <- base::grepl [17:28:33.017] restarts <- computeRestarts(cond) [17:28:33.017] for (restart in restarts) { [17:28:33.017] name <- restart$name [17:28:33.017] if (is.null(name)) [17:28:33.017] next [17:28:33.017] if (!grepl(pattern, name)) [17:28:33.017] next [17:28:33.017] invokeRestart(restart) [17:28:33.017] muffled <- TRUE [17:28:33.017] break [17:28:33.017] } [17:28:33.017] } [17:28:33.017] } [17:28:33.017] invisible(muffled) [17:28:33.017] } [17:28:33.017] muffleCondition(cond) [17:28:33.017] }) [17:28:33.017] })) [17:28:33.017] future::FutureResult(value = ...future.value$value, [17:28:33.017] visible = ...future.value$visible, rng = !identical(base::globalenv()$.Random.seed, [17:28:33.017] ...future.rng), globalenv = if (FALSE) [17:28:33.017] list(added = base::setdiff(base::names(base::.GlobalEnv), [17:28:33.017] ...future.globalenv.names)) [17:28:33.017] else NULL, started = ...future.startTime, version = "1.8") [17:28:33.017] }, condition = base::local({ [17:28:33.017] c <- base::c [17:28:33.017] inherits <- base::inherits [17:28:33.017] invokeRestart <- base::invokeRestart [17:28:33.017] length <- base::length [17:28:33.017] list <- base::list [17:28:33.017] seq.int <- base::seq.int [17:28:33.017] signalCondition <- base::signalCondition [17:28:33.017] sys.calls <- base::sys.calls [17:28:33.017] `[[` <- base::`[[` [17:28:33.017] `+` <- base::`+` [17:28:33.017] `<<-` <- base::`<<-` [17:28:33.017] sysCalls <- function(calls = sys.calls(), from = 1L) { [17:28:33.017] calls[seq.int(from = from + 12L, to = length(calls) - [17:28:33.017] 3L)] [17:28:33.017] } [17:28:33.017] function(cond) { [17:28:33.017] is_error <- inherits(cond, "error") [17:28:33.017] ignore <- !is_error && !is.null(NULL) && inherits(cond, [17:28:33.017] NULL) [17:28:33.017] if (is_error) { [17:28:33.017] sessionInformation <- function() { [17:28:33.017] list(r = base::R.Version(), locale = base::Sys.getlocale(), [17:28:33.017] rngkind = base::RNGkind(), namespaces = base::loadedNamespaces(), [17:28:33.017] search = base::search(), system = base::Sys.info()) [17:28:33.017] } [17:28:33.017] ...future.conditions[[length(...future.conditions) + [17:28:33.017] 1L]] <<- list(condition = cond, calls = c(sysCalls(from = ...future.frame), [17:28:33.017] cond$call), session = sessionInformation(), [17:28:33.017] timestamp = base::Sys.time(), signaled = 0L) [17:28:33.017] signalCondition(cond) [17:28:33.017] } [17:28:33.017] else if (!ignore && TRUE && inherits(cond, c("condition", [17:28:33.017] "immediateCondition"))) { [17:28:33.017] signal <- TRUE && inherits(cond, "immediateCondition") [17:28:33.017] ...future.conditions[[length(...future.conditions) + [17:28:33.017] 1L]] <<- list(condition = cond, signaled = base::as.integer(signal)) [17:28:33.017] if (TRUE && !signal) { [17:28:33.017] muffleCondition <- function (cond, pattern = "^muffle") [17:28:33.017] { [17:28:33.017] inherits <- base::inherits [17:28:33.017] invokeRestart <- base::invokeRestart [17:28:33.017] is.null <- base::is.null [17:28:33.017] muffled <- FALSE [17:28:33.017] if (inherits(cond, "message")) { [17:28:33.017] muffled <- grepl(pattern, "muffleMessage") [17:28:33.017] if (muffled) [17:28:33.017] invokeRestart("muffleMessage") [17:28:33.017] } [17:28:33.017] else if (inherits(cond, "warning")) { [17:28:33.017] muffled <- grepl(pattern, "muffleWarning") [17:28:33.017] if (muffled) [17:28:33.017] invokeRestart("muffleWarning") [17:28:33.017] } [17:28:33.017] else if (inherits(cond, "condition")) { [17:28:33.017] if (!is.null(pattern)) { [17:28:33.017] computeRestarts <- base::computeRestarts [17:28:33.017] grepl <- base::grepl [17:28:33.017] restarts <- computeRestarts(cond) [17:28:33.017] for (restart in restarts) { [17:28:33.017] name <- restart$name [17:28:33.017] if (is.null(name)) [17:28:33.017] next [17:28:33.017] if (!grepl(pattern, name)) [17:28:33.017] next [17:28:33.017] invokeRestart(restart) [17:28:33.017] muffled <- TRUE [17:28:33.017] break [17:28:33.017] } [17:28:33.017] } [17:28:33.017] } [17:28:33.017] invisible(muffled) [17:28:33.017] } [17:28:33.017] muffleCondition(cond, pattern = "^muffle") [17:28:33.017] } [17:28:33.017] } [17:28:33.017] else { [17:28:33.017] if (TRUE) { [17:28:33.017] muffleCondition <- function (cond, pattern = "^muffle") [17:28:33.017] { [17:28:33.017] inherits <- base::inherits [17:28:33.017] invokeRestart <- base::invokeRestart [17:28:33.017] is.null <- base::is.null [17:28:33.017] muffled <- FALSE [17:28:33.017] if (inherits(cond, "message")) { [17:28:33.017] muffled <- grepl(pattern, "muffleMessage") [17:28:33.017] if (muffled) [17:28:33.017] invokeRestart("muffleMessage") [17:28:33.017] } [17:28:33.017] else if (inherits(cond, "warning")) { [17:28:33.017] muffled <- grepl(pattern, "muffleWarning") [17:28:33.017] if (muffled) [17:28:33.017] invokeRestart("muffleWarning") [17:28:33.017] } [17:28:33.017] else if (inherits(cond, "condition")) { [17:28:33.017] if (!is.null(pattern)) { [17:28:33.017] computeRestarts <- base::computeRestarts [17:28:33.017] grepl <- base::grepl [17:28:33.017] restarts <- computeRestarts(cond) [17:28:33.017] for (restart in restarts) { [17:28:33.017] name <- restart$name [17:28:33.017] if (is.null(name)) [17:28:33.017] next [17:28:33.017] if (!grepl(pattern, name)) [17:28:33.017] next [17:28:33.017] invokeRestart(restart) [17:28:33.017] muffled <- TRUE [17:28:33.017] break [17:28:33.017] } [17:28:33.017] } [17:28:33.017] } [17:28:33.017] invisible(muffled) [17:28:33.017] } [17:28:33.017] muffleCondition(cond, pattern = "^muffle") [17:28:33.017] } [17:28:33.017] } [17:28:33.017] } [17:28:33.017] })) [17:28:33.017] }, error = function(ex) { [17:28:33.017] base::structure(base::list(value = NULL, visible = NULL, [17:28:33.017] conditions = ...future.conditions, rng = !identical(base::globalenv()$.Random.seed, [17:28:33.017] ...future.rng), started = ...future.startTime, [17:28:33.017] finished = Sys.time(), session_uuid = NA_character_, [17:28:33.017] version = "1.8"), class = "FutureResult") [17:28:33.017] }, finally = { [17:28:33.017] if (!identical(...future.workdir, getwd())) [17:28:33.017] setwd(...future.workdir) [17:28:33.017] { [17:28:33.017] if (identical(getOption("nwarnings"), ...future.oldOptions$nwarnings)) { [17:28:33.017] ...future.oldOptions$nwarnings <- NULL [17:28:33.017] } [17:28:33.017] base::options(...future.oldOptions) [17:28:33.017] if (.Platform$OS.type == "windows") { [17:28:33.017] old_names <- names(...future.oldEnvVars) [17:28:33.017] envs <- base::Sys.getenv() [17:28:33.017] names <- names(envs) [17:28:33.017] common <- intersect(names, old_names) [17:28:33.017] added <- setdiff(names, old_names) [17:28:33.017] removed <- setdiff(old_names, names) [17:28:33.017] changed <- common[...future.oldEnvVars[common] != [17:28:33.017] envs[common]] [17:28:33.017] NAMES <- toupper(changed) [17:28:33.017] args <- list() [17:28:33.017] for (kk in seq_along(NAMES)) { [17:28:33.017] name <- changed[[kk]] [17:28:33.017] NAME <- NAMES[[kk]] [17:28:33.017] if (name != NAME && is.element(NAME, old_names)) [17:28:33.017] next [17:28:33.017] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:33.017] } [17:28:33.017] NAMES <- toupper(added) [17:28:33.017] for (kk in seq_along(NAMES)) { [17:28:33.017] name <- added[[kk]] [17:28:33.017] NAME <- NAMES[[kk]] [17:28:33.017] if (name != NAME && is.element(NAME, old_names)) [17:28:33.017] next [17:28:33.017] args[[name]] <- "" [17:28:33.017] } [17:28:33.017] NAMES <- toupper(removed) [17:28:33.017] for (kk in seq_along(NAMES)) { [17:28:33.017] name <- removed[[kk]] [17:28:33.017] NAME <- NAMES[[kk]] [17:28:33.017] if (name != NAME && is.element(NAME, old_names)) [17:28:33.017] next [17:28:33.017] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:33.017] } [17:28:33.017] if (length(args) > 0) [17:28:33.017] base::do.call(base::Sys.setenv, args = args) [17:28:33.017] args <- names <- old_names <- NAMES <- envs <- common <- added <- removed <- NULL [17:28:33.017] } [17:28:33.017] else { [17:28:33.017] base::do.call(base::Sys.setenv, args = base::as.list(...future.oldEnvVars)) [17:28:33.017] } [17:28:33.017] { [17:28:33.017] if (base::length(...future.futureOptionsAdded) > [17:28:33.017] 0L) { [17:28:33.017] opts <- base::vector("list", length = base::length(...future.futureOptionsAdded)) [17:28:33.017] base::names(opts) <- ...future.futureOptionsAdded [17:28:33.017] base::options(opts) [17:28:33.017] } [17:28:33.017] { [17:28:33.017] NULL [17:28:33.017] options(future.plan = NULL) [17:28:33.017] if (is.na(NA_character_)) [17:28:33.017] Sys.unsetenv("R_FUTURE_PLAN") [17:28:33.017] else Sys.setenv(R_FUTURE_PLAN = NA_character_) [17:28:33.017] future::plan(...future.strategy.old, .cleanup = FALSE, [17:28:33.017] .init = FALSE) [17:28:33.017] } [17:28:33.017] } [17:28:33.017] } [17:28:33.017] }) [17:28:33.017] if (TRUE) { [17:28:33.017] base::sink(type = "output", split = FALSE) [17:28:33.017] if (TRUE) { [17:28:33.017] ...future.result$stdout <- base::rawToChar(base::rawConnectionValue(...future.stdout)) [17:28:33.017] } [17:28:33.017] else { [17:28:33.017] ...future.result["stdout"] <- base::list(NULL) [17:28:33.017] } [17:28:33.017] base::close(...future.stdout) [17:28:33.017] ...future.stdout <- NULL [17:28:33.017] } [17:28:33.017] ...future.result$conditions <- ...future.conditions [17:28:33.017] ...future.result$finished <- base::Sys.time() [17:28:33.017] ...future.result [17:28:33.017] } [17:28:33.145] ClusterFuture started [17:28:33.146] result() for ClusterFuture ... [17:28:33.146] receiveMessageFromWorker() for ClusterFuture ... [17:28:33.147] - Validating connection of ClusterFuture [17:28:33.234] - received message: FutureResult [17:28:33.235] - Received FutureResult [17:28:33.235] - Erased future from FutureRegistry [17:28:33.235] result() for ClusterFuture ... [17:28:33.235] - result already collected: FutureResult [17:28:33.236] result() for ClusterFuture ... done [17:28:33.236] receiveMessageFromWorker() for ClusterFuture ... done [17:28:33.236] result() for ClusterFuture ... done [17:28:33.236] result() for ClusterFuture ... [17:28:33.236] - result already collected: FutureResult [17:28:33.237] result() for ClusterFuture ... done [17:28:33.237] plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... DONE [17:28:33.246] plan(): nbrOfWorkers() = 1 > n <- nbrOfWorkers() > message(sprintf("nbrOfWorkers: %d", n)) nbrOfWorkers: 1 > stopifnot(n == max(1L, nworkers - 1L)) > > message("Type of future: constant") Type of future: constant > n <- nbrOfWorkers(constant) > message(sprintf("nbrOfWorkers: %d", n)) nbrOfWorkers: 1 > stopifnot(n == 1) > > message("Type of future: ") Type of future: > foo <- structure(function(...) NULL, class = c("future")) > n <- nbrOfWorkers(foo) > message(sprintf("nbrOfWorkers: %g", n)) nbrOfWorkers: Inf > stopifnot(n >= 0, is.infinite(n)) > > > message("Type of future: cluster with workers = ") Type of future: cluster with workers = > > workers <- makeClusterPSOCK(2L) [17:28:33.252] [local output] makeClusterPSOCK() ... [17:28:33.255] [local output] Workers: [n = 2] 'localhost', 'localhost' [17:28:33.259] [local output] Base port: 24409 [17:28:33.259] [local output] Getting setup options for 2 cluster nodes ... [17:28:33.259] [local output] - Node #1 of 2 ... [17:28:33.260] [local output] localMachine=TRUE => revtunnel=FALSE [17:28:33.262] [local output] Rscript port: 24409 [17:28:33.263] [local output] - Node #2 of 2 ... [17:28:33.263] [local output] localMachine=TRUE => revtunnel=FALSE [17:28:33.265] [local output] Rscript port: 24409 [17:28:33.265] [local output] Getting setup options for 2 cluster nodes ... done [17:28:33.265] [local output] - Parallel setup requested for some PSOCK nodes [17:28:33.266] [local output] Setting up PSOCK nodes in parallel [17:28:33.266] List of 36 [17:28:33.266] $ worker : chr "localhost" [17:28:33.266] ..- attr(*, "localhost")= logi TRUE [17:28:33.266] $ master : chr "localhost" [17:28:33.266] $ port : int 24409 [17:28:33.266] $ connectTimeout : num 120 [17:28:33.266] $ timeout : num 120 [17:28:33.266] $ rscript : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\"" [17:28:33.266] $ homogeneous : logi TRUE [17:28:33.266] $ rscript_args : chr "--default-packages=datasets,utils,grDevices,graphics,stats,methods -e \"#label=nbrOfWorkers.R:164204:CRANWIN3:C"| __truncated__ [17:28:33.266] $ rscript_envs : NULL [17:28:33.266] $ rscript_libs : NULL [17:28:33.266] $ rscript_startup : NULL [17:28:33.266] $ rscript_sh : chr [1:2] "cmd" "cmd" [17:28:33.266] $ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:33.266] $ methods : logi TRUE [17:28:33.266] $ socketOptions : chr "no-delay" [17:28:33.266] $ useXDR : logi FALSE [17:28:33.266] $ outfile : chr "/dev/null" [17:28:33.266] $ renice : int NA [17:28:33.266] $ rshcmd : NULL [17:28:33.266] $ user : chr(0) [17:28:33.266] $ revtunnel : logi FALSE [17:28:33.266] $ rshlogfile : NULL [17:28:33.266] $ rshopts : chr(0) [17:28:33.266] $ rank : int 1 [17:28:33.266] $ manual : logi FALSE [17:28:33.266] $ dryrun : logi FALSE [17:28:33.266] $ quiet : logi FALSE [17:28:33.266] $ setup_strategy : chr "parallel" [17:28:33.266] $ local_cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:33.266] $ pidfile : chr "D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c65b573a9.pid" [17:28:33.266] $ rshcmd_label : NULL [17:28:33.266] $ rsh_call : NULL [17:28:33.266] $ cmd : chr "\"D:/RCompile/recent/R/bin/x64/Rscript\" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "| __truncated__ [17:28:33.266] $ localMachine : logi TRUE [17:28:33.266] $ make_fcn :function (worker = getOption2("parallelly.localhost.hostname", "localhost"), [17:28:33.266] master = NULL, port, connectTimeout = getOption2("parallelly.makeNodePSOCK.connectTimeout", [17:28:33.266] 2 * 60), timeout = getOption2("parallelly.makeNodePSOCK.timeout", [17:28:33.266] 30 * 24 * 60 * 60), rscript = NULL, homogeneous = NULL, rscript_args = NULL, [17:28:33.266] rscript_envs = NULL, rscript_libs = NULL, rscript_startup = NULL, rscript_sh = c("auto", [17:28:33.266] "cmd", "sh", "none"), default_packages = c("datasets", "utils", [17:28:33.266] "grDevices", "graphics", "stats", if (methods) "methods"), methods = TRUE, [17:28:33.266] socketOptions = getOption2("parallelly.makeNodePSOCK.socketOptions", [17:28:33.266] "no-delay"), useXDR = getOption2("parallelly.makeNodePSOCK.useXDR", [17:28:33.266] FALSE), outfile = "/dev/null", renice = NA_integer_, rshcmd = getOption2("parallelly.makeNodePSOCK.rshcmd", [17:28:33.266] NULL), user = NULL, revtunnel = NA, rshlogfile = NULL, rshopts = getOption2("parallelly.makeNodePSOCK.rshopts", [17:28:33.266] NULL), rank = 1L, manual = FALSE, dryrun = FALSE, quiet = FALSE, [17:28:33.266] setup_strategy = getOption2("parallelly.makeNodePSOCK.setup_strategy", [17:28:33.266] "parallel"), action = c("launch", "options"), verbose = FALSE) [17:28:33.266] $ arguments :List of 28 [17:28:33.266] ..$ worker : chr "localhost" [17:28:33.266] ..$ master : NULL [17:28:33.266] ..$ port : int 24409 [17:28:33.266] ..$ connectTimeout : num 120 [17:28:33.266] ..$ timeout : num 120 [17:28:33.266] ..$ rscript : NULL [17:28:33.266] ..$ homogeneous : NULL [17:28:33.266] ..$ rscript_args : NULL [17:28:33.266] ..$ rscript_envs : NULL [17:28:33.266] ..$ rscript_libs : NULL [17:28:33.266] ..$ rscript_startup : NULL [17:28:33.266] ..$ rscript_sh : chr "auto" [17:28:33.266] ..$ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ... [17:28:33.266] ..$ methods : logi TRUE [17:28:33.266] ..$ socketOptions : chr "no-delay" [17:28:33.266] ..$ useXDR : logi FALSE [17:28:33.266] ..$ outfile : chr "/dev/null" [17:28:33.266] ..$ renice : int NA [17:28:33.266] ..$ rshcmd : NULL [17:28:33.266] ..$ user : NULL [17:28:33.266] ..$ revtunnel : logi NA [17:28:33.266] ..$ rshlogfile : NULL [17:28:33.266] ..$ rshopts : NULL [17:28:33.266] ..$ rank : int 1 [17:28:33.266] ..$ manual : logi FALSE [17:28:33.266] ..$ dryrun : logi FALSE [17:28:33.266] ..$ quiet : logi FALSE [17:28:33.266] ..$ setup_strategy : chr "parallel" [17:28:33.266] - attr(*, "class")= chr [1:2] "makeNodePSOCKOptions" "makeNodeOptions" [17:28:33.288] [local output] System call to launch all workers: [17:28:33.289] [local output] "D:/RCompile/recent/R/bin/x64/Rscript" --default-packages=datasets,utils,grDevices,graphics,stats,methods -e "#label=nbrOfWorkers.R:164204:CRANWIN3:CRAN" -e "try(suppressWarnings(cat(Sys.getpid(),file=\"D:/temp/RtmpopLFYa/worker.rank=1.parallelly.parent=164204.2816c65b573a9.pid\")), silent = TRUE)" -e "options(socketOptions = \"no-delay\")" -e "workRSOCK <- tryCatch(parallel:::.workRSOCK, error=function(e) parallel:::.slaveRSOCK); workRSOCK()" MASTER=localhost PORT=24409 OUT=/dev/null TIMEOUT=120 XDR=FALSE SETUPTIMEOUT=120 SETUPSTRATEGY=parallel [17:28:33.289] [local output] Starting PSOCK main server [17:28:33.300] [local output] Workers launched [17:28:33.300] [local output] Waiting for workers to connect back [17:28:33.300] - [local output] 0 workers out of 2 ready [17:28:33.593] - [local output] 0 workers out of 2 ready [17:28:33.594] - [local output] 1 workers out of 2 ready [17:28:33.611] - [local output] 1 workers out of 2 ready [17:28:33.611] - [local output] 2 workers out of 2 ready [17:28:33.612] [local output] Launching of 2 workers completed [17:28:33.612] [local output] Number of nodes in cluster: 2 [17:28:33.613] [local output] Collecting session information from 2 workers [17:28:33.614] [local output] - Worker #1 of 2 [17:28:33.616] [local output] - Worker #2 of 2 [17:28:33.616] [local output] makeClusterPSOCK() ... done > print(workers) Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2024-07-28 r86931 ucrt), platform x86_64-w64-mingw32) > plan(cluster, workers = workers) [17:28:33.624] plan(): Setting new future strategy stack: [17:28:33.624] List of future strategies: [17:28:33.624] 1. cluster: [17:28:33.624] - args: function (..., workers = "", envir = parent.frame()) [17:28:33.624] - tweaked: TRUE [17:28:33.624] - call: plan(cluster, workers = workers) [17:28:33.634] plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... [17:28:33.635] cluster: [17:28:33.635] - args: function (..., workers = "", envir = parent.frame()) [17:28:33.635] - tweaked: TRUE [17:28:33.635] - call: plan(cluster, workers = workers) [17:28:33.639] getGlobalsAndPackages() ... [17:28:33.640] Not searching for globals [17:28:33.640] - globals: [0] [17:28:33.640] getGlobalsAndPackages() ... DONE [17:28:33.656] Packages needed by the future expression (n = 0): [17:28:33.656] Packages needed by future strategies (n = 0): [17:28:33.657] { [17:28:33.657] { [17:28:33.657] { [17:28:33.657] ...future.startTime <- base::Sys.time() [17:28:33.657] { [17:28:33.657] { [17:28:33.657] { [17:28:33.657] base::local({ [17:28:33.657] has_future <- base::requireNamespace("future", [17:28:33.657] quietly = TRUE) [17:28:33.657] if (has_future) { [17:28:33.657] ns <- base::getNamespace("future") [17:28:33.657] version <- ns[[".package"]][["version"]] [17:28:33.657] if (is.null(version)) [17:28:33.657] version <- utils::packageVersion("future") [17:28:33.657] } [17:28:33.657] else { [17:28:33.657] version <- NULL [17:28:33.657] } [17:28:33.657] if (!has_future || version < "1.8.0") { [17:28:33.657] info <- base::c(r_version = base::gsub("R version ", [17:28:33.657] "", base::R.version$version.string), [17:28:33.657] platform = base::sprintf("%s (%s-bit)", [17:28:33.657] base::R.version$platform, 8 * base::.Machine$sizeof.pointer), [17:28:33.657] os = base::paste(base::Sys.info()[base::c("sysname", [17:28:33.657] "release", "version")], collapse = " "), [17:28:33.657] hostname = base::Sys.info()[["nodename"]]) [17:28:33.657] info <- base::sprintf("%s: %s", base::names(info), [17:28:33.657] info) [17:28:33.657] info <- base::paste(info, collapse = "; ") [17:28:33.657] if (!has_future) { [17:28:33.657] msg <- base::sprintf("Package 'future' is not installed on worker (%s)", [17:28:33.657] info) [17:28:33.657] } [17:28:33.657] else { [17:28:33.657] msg <- base::sprintf("Package 'future' on worker (%s) must be of version >= 1.8.0: %s", [17:28:33.657] info, version) [17:28:33.657] } [17:28:33.657] base::stop(msg) [17:28:33.657] } [17:28:33.657] }) [17:28:33.657] } [17:28:33.657] ...future.strategy.old <- future::plan("list") [17:28:33.657] options(future.plan = NULL) [17:28:33.657] Sys.unsetenv("R_FUTURE_PLAN") [17:28:33.657] future::plan("default", .cleanup = FALSE, .init = FALSE) [17:28:33.657] } [17:28:33.657] ...future.workdir <- getwd() [17:28:33.657] } [17:28:33.657] ...future.oldOptions <- base::as.list(base::.Options) [17:28:33.657] ...future.oldEnvVars <- base::Sys.getenv() [17:28:33.657] } [17:28:33.657] base::options(future.startup.script = FALSE, future.globals.onMissing = NULL, [17:28:33.657] future.globals.maxSize = NULL, future.globals.method = NULL, [17:28:33.657] future.globals.onMissing = NULL, future.globals.onReference = NULL, [17:28:33.657] future.globals.resolve = NULL, future.resolve.recursive = NULL, [17:28:33.657] future.rng.onMisuse = NULL, future.rng.onMisuse.keepFuture = NULL, [17:28:33.657] future.stdout.windows.reencode = NULL, width = 80L) [17:28:33.657] ...future.futureOptionsAdded <- base::setdiff(base::names(base::.Options), [17:28:33.657] base::names(...future.oldOptions)) [17:28:33.657] } [17:28:33.657] if (FALSE) { [17:28:33.657] } [17:28:33.657] else { [17:28:33.657] if (TRUE) { [17:28:33.657] ...future.stdout <- base::rawConnection(base::raw(0L), [17:28:33.657] open = "w") [17:28:33.657] } [17:28:33.657] else { [17:28:33.657] ...future.stdout <- base::file(base::switch(.Platform$OS.type, [17:28:33.657] windows = "NUL", "/dev/null"), open = "w") [17:28:33.657] } [17:28:33.657] base::sink(...future.stdout, type = "output", split = FALSE) [17:28:33.657] base::on.exit(if (!base::is.null(...future.stdout)) { [17:28:33.657] base::sink(type = "output", split = FALSE) [17:28:33.657] base::close(...future.stdout) [17:28:33.657] }, add = TRUE) [17:28:33.657] } [17:28:33.657] ...future.frame <- base::sys.nframe() [17:28:33.657] ...future.conditions <- base::list() [17:28:33.657] ...future.rng <- base::globalenv()$.Random.seed [17:28:33.657] if (FALSE) { [17:28:33.657] ...future.globalenv.names <- c(base::names(base::.GlobalEnv), [17:28:33.657] "...future.value", "...future.globalenv.names", ".Random.seed") [17:28:33.657] } [17:28:33.657] ...future.result <- base::tryCatch({ [17:28:33.657] base::withCallingHandlers({ [17:28:33.657] ...future.value <- base::withVisible(base::local({ [17:28:33.657] ...future.makeSendCondition <- base::local({ [17:28:33.657] sendCondition <- NULL [17:28:33.657] function(frame = 1L) { [17:28:33.657] if (is.function(sendCondition)) [17:28:33.657] return(sendCondition) [17:28:33.657] ns <- getNamespace("parallel") [17:28:33.657] if (exists("sendData", mode = "function", [17:28:33.657] envir = ns)) { [17:28:33.657] parallel_sendData <- get("sendData", mode = "function", [17:28:33.657] envir = ns) [17:28:33.657] envir <- sys.frame(frame) [17:28:33.657] master <- NULL [17:28:33.657] while (!identical(envir, .GlobalEnv) && [17:28:33.657] !identical(envir, emptyenv())) { [17:28:33.657] if (exists("master", mode = "list", envir = envir, [17:28:33.657] inherits = FALSE)) { [17:28:33.657] master <- get("master", mode = "list", [17:28:33.657] envir = envir, inherits = FALSE) [17:28:33.657] if (inherits(master, c("SOCKnode", [17:28:33.657] "SOCK0node"))) { [17:28:33.657] sendCondition <<- function(cond) { [17:28:33.657] data <- list(type = "VALUE", value = cond, [17:28:33.657] success = TRUE) [17:28:33.657] parallel_sendData(master, data) [17:28:33.657] } [17:28:33.657] return(sendCondition) [17:28:33.657] } [17:28:33.657] } [17:28:33.657] frame <- frame + 1L [17:28:33.657] envir <- sys.frame(frame) [17:28:33.657] } [17:28:33.657] } [17:28:33.657] sendCondition <<- function(cond) NULL [17:28:33.657] } [17:28:33.657] }) [17:28:33.657] withCallingHandlers({ [17:28:33.657] NA [17:28:33.657] }, immediateCondition = function(cond) { [17:28:33.657] sendCondition <- ...future.makeSendCondition() [17:28:33.657] sendCondition(cond) [17:28:33.657] muffleCondition <- function (cond, pattern = "^muffle") [17:28:33.657] { [17:28:33.657] inherits <- base::inherits [17:28:33.657] invokeRestart <- base::invokeRestart [17:28:33.657] is.null <- base::is.null [17:28:33.657] muffled <- FALSE [17:28:33.657] if (inherits(cond, "message")) { [17:28:33.657] muffled <- grepl(pattern, "muffleMessage") [17:28:33.657] if (muffled) [17:28:33.657] invokeRestart("muffleMessage") [17:28:33.657] } [17:28:33.657] else if (inherits(cond, "warning")) { [17:28:33.657] muffled <- grepl(pattern, "muffleWarning") [17:28:33.657] if (muffled) [17:28:33.657] invokeRestart("muffleWarning") [17:28:33.657] } [17:28:33.657] else if (inherits(cond, "condition")) { [17:28:33.657] if (!is.null(pattern)) { [17:28:33.657] computeRestarts <- base::computeRestarts [17:28:33.657] grepl <- base::grepl [17:28:33.657] restarts <- computeRestarts(cond) [17:28:33.657] for (restart in restarts) { [17:28:33.657] name <- restart$name [17:28:33.657] if (is.null(name)) [17:28:33.657] next [17:28:33.657] if (!grepl(pattern, name)) [17:28:33.657] next [17:28:33.657] invokeRestart(restart) [17:28:33.657] muffled <- TRUE [17:28:33.657] break [17:28:33.657] } [17:28:33.657] } [17:28:33.657] } [17:28:33.657] invisible(muffled) [17:28:33.657] } [17:28:33.657] muffleCondition(cond) [17:28:33.657] }) [17:28:33.657] })) [17:28:33.657] future::FutureResult(value = ...future.value$value, [17:28:33.657] visible = ...future.value$visible, rng = !identical(base::globalenv()$.Random.seed, [17:28:33.657] ...future.rng), globalenv = if (FALSE) [17:28:33.657] list(added = base::setdiff(base::names(base::.GlobalEnv), [17:28:33.657] ...future.globalenv.names)) [17:28:33.657] else NULL, started = ...future.startTime, version = "1.8") [17:28:33.657] }, condition = base::local({ [17:28:33.657] c <- base::c [17:28:33.657] inherits <- base::inherits [17:28:33.657] invokeRestart <- base::invokeRestart [17:28:33.657] length <- base::length [17:28:33.657] list <- base::list [17:28:33.657] seq.int <- base::seq.int [17:28:33.657] signalCondition <- base::signalCondition [17:28:33.657] sys.calls <- base::sys.calls [17:28:33.657] `[[` <- base::`[[` [17:28:33.657] `+` <- base::`+` [17:28:33.657] `<<-` <- base::`<<-` [17:28:33.657] sysCalls <- function(calls = sys.calls(), from = 1L) { [17:28:33.657] calls[seq.int(from = from + 12L, to = length(calls) - [17:28:33.657] 3L)] [17:28:33.657] } [17:28:33.657] function(cond) { [17:28:33.657] is_error <- inherits(cond, "error") [17:28:33.657] ignore <- !is_error && !is.null(NULL) && inherits(cond, [17:28:33.657] NULL) [17:28:33.657] if (is_error) { [17:28:33.657] sessionInformation <- function() { [17:28:33.657] list(r = base::R.Version(), locale = base::Sys.getlocale(), [17:28:33.657] rngkind = base::RNGkind(), namespaces = base::loadedNamespaces(), [17:28:33.657] search = base::search(), system = base::Sys.info()) [17:28:33.657] } [17:28:33.657] ...future.conditions[[length(...future.conditions) + [17:28:33.657] 1L]] <<- list(condition = cond, calls = c(sysCalls(from = ...future.frame), [17:28:33.657] cond$call), session = sessionInformation(), [17:28:33.657] timestamp = base::Sys.time(), signaled = 0L) [17:28:33.657] signalCondition(cond) [17:28:33.657] } [17:28:33.657] else if (!ignore && TRUE && inherits(cond, c("condition", [17:28:33.657] "immediateCondition"))) { [17:28:33.657] signal <- TRUE && inherits(cond, "immediateCondition") [17:28:33.657] ...future.conditions[[length(...future.conditions) + [17:28:33.657] 1L]] <<- list(condition = cond, signaled = base::as.integer(signal)) [17:28:33.657] if (TRUE && !signal) { [17:28:33.657] muffleCondition <- function (cond, pattern = "^muffle") [17:28:33.657] { [17:28:33.657] inherits <- base::inherits [17:28:33.657] invokeRestart <- base::invokeRestart [17:28:33.657] is.null <- base::is.null [17:28:33.657] muffled <- FALSE [17:28:33.657] if (inherits(cond, "message")) { [17:28:33.657] muffled <- grepl(pattern, "muffleMessage") [17:28:33.657] if (muffled) [17:28:33.657] invokeRestart("muffleMessage") [17:28:33.657] } [17:28:33.657] else if (inherits(cond, "warning")) { [17:28:33.657] muffled <- grepl(pattern, "muffleWarning") [17:28:33.657] if (muffled) [17:28:33.657] invokeRestart("muffleWarning") [17:28:33.657] } [17:28:33.657] else if (inherits(cond, "condition")) { [17:28:33.657] if (!is.null(pattern)) { [17:28:33.657] computeRestarts <- base::computeRestarts [17:28:33.657] grepl <- base::grepl [17:28:33.657] restarts <- computeRestarts(cond) [17:28:33.657] for (restart in restarts) { [17:28:33.657] name <- restart$name [17:28:33.657] if (is.null(name)) [17:28:33.657] next [17:28:33.657] if (!grepl(pattern, name)) [17:28:33.657] next [17:28:33.657] invokeRestart(restart) [17:28:33.657] muffled <- TRUE [17:28:33.657] break [17:28:33.657] } [17:28:33.657] } [17:28:33.657] } [17:28:33.657] invisible(muffled) [17:28:33.657] } [17:28:33.657] muffleCondition(cond, pattern = "^muffle") [17:28:33.657] } [17:28:33.657] } [17:28:33.657] else { [17:28:33.657] if (TRUE) { [17:28:33.657] muffleCondition <- function (cond, pattern = "^muffle") [17:28:33.657] { [17:28:33.657] inherits <- base::inherits [17:28:33.657] invokeRestart <- base::invokeRestart [17:28:33.657] is.null <- base::is.null [17:28:33.657] muffled <- FALSE [17:28:33.657] if (inherits(cond, "message")) { [17:28:33.657] muffled <- grepl(pattern, "muffleMessage") [17:28:33.657] if (muffled) [17:28:33.657] invokeRestart("muffleMessage") [17:28:33.657] } [17:28:33.657] else if (inherits(cond, "warning")) { [17:28:33.657] muffled <- grepl(pattern, "muffleWarning") [17:28:33.657] if (muffled) [17:28:33.657] invokeRestart("muffleWarning") [17:28:33.657] } [17:28:33.657] else if (inherits(cond, "condition")) { [17:28:33.657] if (!is.null(pattern)) { [17:28:33.657] computeRestarts <- base::computeRestarts [17:28:33.657] grepl <- base::grepl [17:28:33.657] restarts <- computeRestarts(cond) [17:28:33.657] for (restart in restarts) { [17:28:33.657] name <- restart$name [17:28:33.657] if (is.null(name)) [17:28:33.657] next [17:28:33.657] if (!grepl(pattern, name)) [17:28:33.657] next [17:28:33.657] invokeRestart(restart) [17:28:33.657] muffled <- TRUE [17:28:33.657] break [17:28:33.657] } [17:28:33.657] } [17:28:33.657] } [17:28:33.657] invisible(muffled) [17:28:33.657] } [17:28:33.657] muffleCondition(cond, pattern = "^muffle") [17:28:33.657] } [17:28:33.657] } [17:28:33.657] } [17:28:33.657] })) [17:28:33.657] }, error = function(ex) { [17:28:33.657] base::structure(base::list(value = NULL, visible = NULL, [17:28:33.657] conditions = ...future.conditions, rng = !identical(base::globalenv()$.Random.seed, [17:28:33.657] ...future.rng), started = ...future.startTime, [17:28:33.657] finished = Sys.time(), session_uuid = NA_character_, [17:28:33.657] version = "1.8"), class = "FutureResult") [17:28:33.657] }, finally = { [17:28:33.657] if (!identical(...future.workdir, getwd())) [17:28:33.657] setwd(...future.workdir) [17:28:33.657] { [17:28:33.657] if (identical(getOption("nwarnings"), ...future.oldOptions$nwarnings)) { [17:28:33.657] ...future.oldOptions$nwarnings <- NULL [17:28:33.657] } [17:28:33.657] base::options(...future.oldOptions) [17:28:33.657] if (.Platform$OS.type == "windows") { [17:28:33.657] old_names <- names(...future.oldEnvVars) [17:28:33.657] envs <- base::Sys.getenv() [17:28:33.657] names <- names(envs) [17:28:33.657] common <- intersect(names, old_names) [17:28:33.657] added <- setdiff(names, old_names) [17:28:33.657] removed <- setdiff(old_names, names) [17:28:33.657] changed <- common[...future.oldEnvVars[common] != [17:28:33.657] envs[common]] [17:28:33.657] NAMES <- toupper(changed) [17:28:33.657] args <- list() [17:28:33.657] for (kk in seq_along(NAMES)) { [17:28:33.657] name <- changed[[kk]] [17:28:33.657] NAME <- NAMES[[kk]] [17:28:33.657] if (name != NAME && is.element(NAME, old_names)) [17:28:33.657] next [17:28:33.657] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:33.657] } [17:28:33.657] NAMES <- toupper(added) [17:28:33.657] for (kk in seq_along(NAMES)) { [17:28:33.657] name <- added[[kk]] [17:28:33.657] NAME <- NAMES[[kk]] [17:28:33.657] if (name != NAME && is.element(NAME, old_names)) [17:28:33.657] next [17:28:33.657] args[[name]] <- "" [17:28:33.657] } [17:28:33.657] NAMES <- toupper(removed) [17:28:33.657] for (kk in seq_along(NAMES)) { [17:28:33.657] name <- removed[[kk]] [17:28:33.657] NAME <- NAMES[[kk]] [17:28:33.657] if (name != NAME && is.element(NAME, old_names)) [17:28:33.657] next [17:28:33.657] args[[name]] <- ...future.oldEnvVars[[name]] [17:28:33.657] } [17:28:33.657] if (length(args) > 0) [17:28:33.657] base::do.call(base::Sys.setenv, args = args) [17:28:33.657] args <- names <- old_names <- NAMES <- envs <- common <- added <- removed <- NULL [17:28:33.657] } [17:28:33.657] else { [17:28:33.657] base::do.call(base::Sys.setenv, args = base::as.list(...future.oldEnvVars)) [17:28:33.657] } [17:28:33.657] { [17:28:33.657] if (base::length(...future.futureOptionsAdded) > [17:28:33.657] 0L) { [17:28:33.657] opts <- base::vector("list", length = base::length(...future.futureOptionsAdded)) [17:28:33.657] base::names(opts) <- ...future.futureOptionsAdded [17:28:33.657] base::options(opts) [17:28:33.657] } [17:28:33.657] { [17:28:33.657] NULL [17:28:33.657] options(future.plan = NULL) [17:28:33.657] if (is.na(NA_character_)) [17:28:33.657] Sys.unsetenv("R_FUTURE_PLAN") [17:28:33.657] else Sys.setenv(R_FUTURE_PLAN = NA_character_) [17:28:33.657] future::plan(...future.strategy.old, .cleanup = FALSE, [17:28:33.657] .init = FALSE) [17:28:33.657] } [17:28:33.657] } [17:28:33.657] } [17:28:33.657] }) [17:28:33.657] if (TRUE) { [17:28:33.657] base::sink(type = "output", split = FALSE) [17:28:33.657] if (TRUE) { [17:28:33.657] ...future.result$stdout <- base::rawToChar(base::rawConnectionValue(...future.stdout)) [17:28:33.657] } [17:28:33.657] else { [17:28:33.657] ...future.result["stdout"] <- base::list(NULL) [17:28:33.657] } [17:28:33.657] base::close(...future.stdout) [17:28:33.657] ...future.stdout <- NULL [17:28:33.657] } [17:28:33.657] ...future.result$conditions <- ...future.conditions [17:28:33.657] ...future.result$finished <- base::Sys.time() [17:28:33.657] ...future.result [17:28:33.657] } [17:28:33.803] ClusterFuture started [17:28:33.803] result() for ClusterFuture ... [17:28:33.803] receiveMessageFromWorker() for ClusterFuture ... [17:28:33.804] - Validating connection of ClusterFuture [17:28:33.875] - received message: FutureResult [17:28:33.876] - Received FutureResult [17:28:33.876] - Erased future from FutureRegistry [17:28:33.876] result() for ClusterFuture ... [17:28:33.877] - result already collected: FutureResult [17:28:33.877] result() for ClusterFuture ... done [17:28:33.877] receiveMessageFromWorker() for ClusterFuture ... done [17:28:33.881] result() for ClusterFuture ... done [17:28:33.881] result() for ClusterFuture ... [17:28:33.881] - result already collected: FutureResult [17:28:33.881] result() for ClusterFuture ... done [17:28:33.882] plan(): plan_init() of 'tweaked', 'cluster', 'multiprocess', 'future', 'function' ... DONE [17:28:33.882] plan(): nbrOfWorkers() = 2 > n <- nbrOfWorkers() > message(sprintf("nbrOfWorkers: %g", n)) nbrOfWorkers: 2 > stopifnot(n == length(workers)) > parallel::stopCluster(workers) > > message("*** nbrOfWorkers() ... DONE") *** nbrOfWorkers() ... DONE > > source("incl/end.R") [17:28:33.891] plan(): Setting new future strategy stack: [17:28:33.892] List of future strategies: [17:28:33.892] 1. FutureStrategy: [17:28:33.892] - args: function (..., envir = parent.frame(), workers = "") [17:28:33.892] - tweaked: FALSE [17:28:33.892] - call: future::plan(oplan) [17:28:33.893] plan(): nbrOfWorkers() = 1 Failed to undo environment variables: - Expected environment variables: [n=205] '!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', 'RTOOLS43_HOME', 'RTOOLS44_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_RTOOLS44_PATH', 'R_SCRIPT_LEGACY', 'R_SHARE_DIR', '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_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_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_CHECK_DOC_FILES_NOTE_IF_ALL_SPECIAL__', 'maj.version', 'nextArg--timingsnextArg--install' - Environment variables still there: [n=0] - Environment variables missing: [n=1] 'MAKEFLAGS' Differences environment variable by environment variable: List of 3 $ name : chr "MAKEFLAGS" $ expected: 'Dlist' chr "" $ actual : 'Dlist' chr NA > > proc.time() user system elapsed 1.09 0.06 3.59