R Under development (unstable) (2025-06-04 r88278 ucrt) -- "Unsuffered Consequences" Copyright (C) 2025 The R Foundation for Statistical Computing Platform: x86_64-w64-mingw32/x64 R is free software and comes with ABSOLUTELY NO WARRANTY. You are welcome to redistribute it under certain conditions. Type 'license()' or 'licence()' for distribution details. R is a collaborative project with many contributors. Type 'contributors()' for more information and 'citation()' on how to cite R or R packages in publications. Type 'demo()' for some demos, 'help()' for on-line help, or 'help.start()' for an HTML browser interface to help. Type 'q()' to quit R. > ## This runs testme test script inst/testme/test-backtrace.R > ## Don't edit - it was autogenerated by inst/testme/deploy.R > future:::testme("backtrace") Test 'backtrace' ... Sourcing 9 prologue scripts ... 01/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/001.load.R' 02/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/002.record-state.R' 03/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/030.imports.R' 04/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/050.utils.R' 05/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/090.context.R' 06/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/090.options.R' 07/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/091.envvars.R' 08/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/099.future-setup.R' 09/09 prologue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_prologue/995.detrius-connections.R' Sourcing 9 prologue scripts ... done Running test script: 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/test-backtrace.R' > library(future) [05:57:05.396] Option 'future.startup.script': TRUE [05:57:05.398] Future startup scripts considered: '.future.R', '~/.future.R' [05:57:05.398] Future startup scripts found: > message("*** backtrace( ) - explicit future ...") *** backtrace( ) - explicit future ... > f <- future({ + 42 + stop("Woops") + }) [05:57:05.401] future(..., label = NULL) ... [05:57:05.401] | lazy: FALSE [05:57:05.402] | stdout: TRUE [05:57:05.402] | conditions: [n=1] 'condition' [05:57:05.402] | gc: FALSE [05:57:05.402] | earlySignal: FALSE [05:57:05.404] | getGlobalsAndPackages() ... [05:57:05.404] | : Searching for globals ... [05:57:05.431] | : . globals found: [2] '{', 'stop' [05:57:05.431] | : Searching for globals ... done [05:57:05.432] | : Resolving globals: FALSE [05:57:05.432] | : Search for packages associated with the globals ... [05:57:05.432] | : . Packages associated with globals: [1] 'base' [05:57:05.433] | : . Packages: [1] 'base' [05:57:05.433] | : Search for packages associated with the globals ... done [05:57:05.434] | : Packages after dropping 'base': [0] [05:57:05.434] | : globals: [0] [05:57:05.434] | : packages: [0] [05:57:05.435] | getGlobalsAndPackages() ... done [05:57:05.436] | run() for 'Future' () ... [05:57:05.436] | : state: 'created' [05:57:05.437] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.437] | : . plan(): plan_init() of 'sequential', 'uniprocess', 'future', 'function' ... [05:57:05.437] | : . ' function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.437] | : . ' - attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.437] | : . ' - attr(*, "init")= logi TRUE [05:57:05.437] | : . ' - attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.437] | : . ' ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.437] | : . ' - attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.437] | : . ' - attr(*, "call")= language plan(sequential) [05:57:05.445] | : . ' init: TRUE [05:57:05.446] | : . ' makeFutureBackend() ... [05:57:05.446] | : . ' , Backend function: <'NULL'> [05:57:05.447] | : . ' , Evaluator tweak arguments: [n=0] [05:57:05.447] | : . ' , list() [05:57:05.448] | : . ' , Evaluator formal arguments: [n=2] [05:57:05.448] | : . ' , list() [05:57:05.448] | : . ' , Backend factory arguments: [n=2] [05:57:05.449] | : . ' , Dotted pair list of 2 [05:57:05.449] | : . ' , $ gc : logi FALSE [05:57:05.449] | : . ' , $ earlySignal: logi FALSE [05:57:05.451] | : . ' , Backend: <'SequentialFutureBackend', 'FutureBackend', 'environment'> [05:57:05.452] | : . ' makeFutureBackend() ... done [05:57:05.452] | : . plan(): plan_init() of 'sequential', 'uniprocess', 'future', 'function' ... done [05:57:05.452] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.452] | : Using SequentialFutureBackend ... [05:57:05.453] | : . Number of futures since start: 0 (0 created, 0 launched, 0 finished) [05:57:05.453] | : . Launching futures ... [05:57:05.454] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:05.454] | : . ' , getFutureData() ... [05:57:05.454] | : . ' , ; getFutureCore() ... [05:57:05.455] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:05.455] | : . ' , ; getFutureCore() ... done [05:57:05.455] | : . ' , ; getFutureCapture() ... [05:57:05.456] | : . ' , ; getFutureCapture() ... done [05:57:05.456] | : . ' , ; getFutureContext() ... [05:57:05.456] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.457] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:05.457] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.457] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:05.458] | : . ' , ; getFutureContext() ... done [05:57:05.458] | : . ' , getFutureData() ... done [05:57:05.463] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.464] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:05.464] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.465] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.465] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.466] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:05.466] | : . ' , ; ` | New stack: [05:57:05.466] | : . ' , ; ` | List of 1 [05:57:05.466] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.466] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.466] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:05.466] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.466] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.466] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.466] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.466] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.475] | : . ' , ; ` | Old stack: [05:57:05.476] | : . ' , ; ` | List of 1 [05:57:05.476] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.476] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.476] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:05.476] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.476] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.476] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.476] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:05.476] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.476] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.476] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.476] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.482] | : . ' , ; ` | Not identical [05:57:05.482] | : . ' , ; ` | all.equal() for future ... [05:57:05.483] | : . ' , ; ` | : List of 2 [05:57:05.483] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.483] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.483] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.483] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.483] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.483] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.483] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.493] | : . ' , ; ` | all.equal() for future ... done [05:57:05.494] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:05.494] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.494] | : . ' , ; ` List of future strategies: [05:57:05.494] | : . ' , ; ` 1. sequential: [05:57:05.494] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.494] | : . ' , ; ` - tweaked: FALSE [05:57:05.494] | : . ' , ; ` - call: plan(sequential) [05:57:05.496] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.496] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.502] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.503] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.503] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.503] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:05.504] | : . ' , ; ` | : New stack: [05:57:05.504] | : . ' , ; ` | : List of 1 [05:57:05.504] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.504] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.504] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.504] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.504] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.504] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.504] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.504] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.504] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.504] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.504] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.551] | : . ' , ; ` | : Old stack: [05:57:05.551] | : . ' , ; ` | : List of 1 [05:57:05.551] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.551] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.551] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.551] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.551] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.551] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.551] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.551] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.551] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.551] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.551] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.557] | : . ' , ; ` | : Identical [05:57:05.558] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:05.558] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.558] | : . ' , ; ` | List of future strategies: [05:57:05.558] | : . ' , ; ` | 1. sequential: [05:57:05.558] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.558] | : . ' , ; ` | - tweaked: FALSE [05:57:05.558] | : . ' , ; ` | - call: plan(sequential) [05:57:05.559] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.559] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.560] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.566] | : . ' , SequentialFuture started (and completed) [05:57:05.566] | : . ' , signalConditions() ... [05:57:05.567] | : . ' , ; include = 'immediateCondition' [05:57:05.567] | : . ' , ; exclude = [05:57:05.567] | : . ' , ; resignal = FALSE [05:57:05.568] | : . ' , ; Number of conditions: 7 [05:57:05.568] | : . ' , ; int 7 [05:57:05.569] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.569] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.569] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.570] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.570] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.570] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.571] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:05.571] | : . ' , signalConditions() ... done [05:57:05.572] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:05.572] | : . Launching futures ... done [05:57:05.572] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:05.572] | : Using SequentialFutureBackend ... done [05:57:05.573] | run() for 'Future' () ... done [05:57:05.573] future(..., label = NULL) ... done > v <- value(f, signal = FALSE) [05:57:05.574] value() for SequentialFuture () ... [05:57:05.616] | signalConditions() ... [05:57:05.616] | : include = 'immediateCondition' [05:57:05.617] | : exclude = [05:57:05.617] | : resignal = FALSE [05:57:05.617] | : Number of conditions: 7 [05:57:05.617] | : int 7 [05:57:05.618] | : Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.619] | : Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.619] | : Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.619] | : Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.619] | : Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.620] | : Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.620] | : Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:05.620] | signalConditions() ... done [05:57:05.620] | relay stdout ... [05:57:05.621] | relay stdout ... done [05:57:05.621] | check for misuse ... [05:57:05.621] | check for misuse ... done [05:57:05.621] value() for SequentialFuture () ... done > print(v) > calls <- backtrace(f) [05:57:05.623] resolved() for SequentialFuture () ... [05:57:05.623] | state: 'finished' [05:57:05.624] | run: TRUE [05:57:05.624] | result: 'FutureResult' [05:57:05.624] resolved() for SequentialFuture () ... done > print(calls) [[1]] future:::testme("backtrace") [[2]] source(file.path(path, "run.R")) [[3]] withVisible(eval(ei, envir)) [[4]] eval(ei, envir) [[5]] eval(ei, envir) [[6]] source(testme[["script"]], echo = TRUE) [[7]] withVisible(eval(ei, envir)) [[8]] eval(ei, envir) [[9]] eval(ei, envir) [[10]] future({ 42L stop("Woops") }) [[11]] Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) [[12]] eval(expr, envir = globalenv()) [[13]] eval(expr, envir = globalenv()) [[14]] local({ { 42L stop("Woops") } }) [[15]] eval.parent(substitute(eval(quote(expr), envir))) [[16]] eval(expr, p) [[17]] eval(expr, p) [[18]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[19]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[20]] stop("Woops") [[21]] eval(quote({ { 42L stop("Woops") } }), new.env()) > message("*** backtrace( ) - explicit future ... DONE") *** backtrace( ) - explicit future ... DONE > message("*** backtrace( ) - implicit future ...") *** backtrace( ) - implicit future ... > v %<-% { + 42 + stop("Woops") + } [05:57:05.626] future(..., label = NULL) ... [05:57:05.627] | lazy: FALSE [05:57:05.627] | stdout: TRUE [05:57:05.627] | conditions: [n=1] 'condition' [05:57:05.627] | gc: FALSE [05:57:05.628] | earlySignal: FALSE [05:57:05.628] | getGlobalsAndPackages() ... [05:57:05.628] | : Searching for globals ... [05:57:05.637] | : . globals found: [2] '{', 'stop' [05:57:05.638] | : Searching for globals ... done [05:57:05.638] | : Resolving globals: FALSE [05:57:05.638] | : Search for packages associated with the globals ... [05:57:05.638] | : . Packages associated with globals: [1] 'base' [05:57:05.639] | : . Packages: [1] 'base' [05:57:05.639] | : Search for packages associated with the globals ... done [05:57:05.639] | : Packages after dropping 'base': [0] [05:57:05.639] | : globals: [0] [05:57:05.640] | : packages: [0] [05:57:05.640] | getGlobalsAndPackages() ... done [05:57:05.640] | run() for 'Future' () ... [05:57:05.640] | : state: 'created' [05:57:05.641] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.641] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.641] | : Using SequentialFutureBackend ... [05:57:05.641] | : . Number of futures since start: 1 (1 created, 1 launched, 1 finished) [05:57:05.641] | : . Launching futures ... [05:57:05.641] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:05.642] | : . ' , getFutureData() ... [05:57:05.642] | : . ' , ; getFutureCore() ... [05:57:05.642] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:05.642] | : . ' , ; getFutureCore() ... done [05:57:05.642] | : . ' , ; getFutureCapture() ... [05:57:05.642] | : . ' , ; getFutureCapture() ... done [05:57:05.643] | : . ' , ; getFutureContext() ... [05:57:05.643] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.643] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:05.643] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.643] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:05.643] | : . ' , ; getFutureContext() ... done [05:57:05.644] | : . ' , getFutureData() ... done [05:57:05.645] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.646] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:05.646] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.646] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.646] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.647] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:05.647] | : . ' , ; ` | New stack: [05:57:05.647] | : . ' , ; ` | List of 1 [05:57:05.647] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.647] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.647] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:05.647] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.647] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.647] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.647] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.647] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.651] | : . ' , ; ` | Old stack: [05:57:05.651] | : . ' , ; ` | List of 1 [05:57:05.651] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.651] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.651] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:05.651] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.651] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.651] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.651] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:05.651] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.651] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.651] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.651] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.656] | : . ' , ; ` | Not identical [05:57:05.657] | : . ' , ; ` | all.equal() for future ... [05:57:05.657] | : . ' , ; ` | : List of 2 [05:57:05.657] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.657] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.657] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.657] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.657] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.657] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.657] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.665] | : . ' , ; ` | all.equal() for future ... done [05:57:05.665] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:05.665] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.665] | : . ' , ; ` List of future strategies: [05:57:05.665] | : . ' , ; ` 1. sequential: [05:57:05.665] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.665] | : . ' , ; ` - tweaked: FALSE [05:57:05.665] | : . ' , ; ` - call: plan(sequential) [05:57:05.666] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.666] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.670] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.670] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.670] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.670] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:05.671] | : . ' , ; ` | : New stack: [05:57:05.671] | : . ' , ; ` | : List of 1 [05:57:05.671] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.671] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.671] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.671] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.671] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.671] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.671] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.671] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.671] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.671] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.671] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.676] | : . ' , ; ` | : Old stack: [05:57:05.676] | : . ' , ; ` | : List of 1 [05:57:05.676] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.676] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.676] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.676] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.676] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.676] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.676] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.676] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.676] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.676] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.676] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.681] | : . ' , ; ` | : Identical [05:57:05.681] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:05.681] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.681] | : . ' , ; ` | List of future strategies: [05:57:05.681] | : . ' , ; ` | 1. sequential: [05:57:05.681] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.681] | : . ' , ; ` | - tweaked: FALSE [05:57:05.681] | : . ' , ; ` | - call: plan(sequential) [05:57:05.682] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.682] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.683] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.683] | : . ' , SequentialFuture started (and completed) [05:57:05.683] | : . ' , signalConditions() ... [05:57:05.684] | : . ' , ; include = 'immediateCondition' [05:57:05.684] | : . ' , ; exclude = [05:57:05.684] | : . ' , ; resignal = FALSE [05:57:05.684] | : . ' , ; Number of conditions: 7 [05:57:05.684] | : . ' , ; int 7 [05:57:05.685] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.685] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.685] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.685] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.686] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.686] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.686] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:05.686] | : . ' , signalConditions() ... done [05:57:05.686] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:05.687] | : . Launching futures ... done [05:57:05.687] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:05.687] | : Using SequentialFutureBackend ... done [05:57:05.687] | run() for 'Future' () ... done [05:57:05.687] future(..., label = NULL) ... done > calls <- backtrace(v) [05:57:05.688] resolved() for SequentialFuture () ... [05:57:05.688] | state: 'finished' [05:57:05.688] | run: TRUE [05:57:05.689] | result: 'FutureResult' [05:57:05.689] resolved() for SequentialFuture () ... done > print(calls) [[1]] future:::testme("backtrace") [[2]] source(file.path(path, "run.R")) [[3]] withVisible(eval(ei, envir)) [[4]] eval(ei, envir) [[5]] eval(ei, envir) [[6]] source(testme[["script"]], echo = TRUE) [[7]] withVisible(eval(ei, envir)) [[8]] eval(ei, envir) [[9]] eval(ei, envir) [[10]] v %<-% { 42L stop("Woops") } [[11]] futureAssignInternal(target, expr, envir = envir, substitute = FALSE) [[12]] futureAssign(name, expr, envir = envir, assign.env = assign.env, substitute = FALSE) [[13]] do.call(future::future, args = future.args, envir = envir) [[14]] (function (expr, envir = parent.frame(), substitute = TRUE, lazy = FALSE, seed = FALSE, globals = TRUE, packages = NULL, stdout = TRUE, conditions = "condition", label = NULL, gc = FALSE, earlySignal = FALSE, ...) { debug <- isTRUE(getOption("future.debug")) if (debug) { mdebugf_push("future(..., label = %s) ...", sQuoteLabel(label)) mdebugf("lazy: %s", lazy) mdebugf("stdout: %s", stdout) mdebugf("conditions: [n=%d] %s", length(conditions), commaq(conditions)) mdebugf("gc: %s", gc) mdebugf("earlySignal: %s", earlySignal) on.exit(mdebugf_pop()) } if (substitute) expr <- substitute(expr) t_start <- Sys.time() onReference <- getOption("future.globals.onReference") if (is.null(onReference)) onReference <- "ignore" if (!is.null(globals)) { gp <- getGlobalsAndPackages(expr, envir = envir, tweak = tweakExpression, globals = globals, onReference = onReference, maxSize = +Inf) expr <- gp[["expr"]] globals <- gp[["globals"]] if (length(packages) > 0 || length(gp[["packages"]]) > 0) { packages <- c(gp[["packages"]], packages) } gp <- NULL attr(globals, "already-done") <- TRUE } future <- Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) future[[".defaultLocal"]] <- !is.element("local", names(list(...))) if (isTRUE(getOption("future.journal"))) { future <- makeFutureJournal(future, event = "create", category = "overhead", start = t_start) } if (!lazy) { future <- run(future) future[["lazy"]] <- FALSE stop_if_not(inherits(future, "Future"), !future[["lazy"]]) } future })({ 42L stop("Woops") }, envir = , lazy = FALSE, seed = FALSE, globals = TRUE, packages = NULL, stdout = TRUE, conditions = "condition", earlySignal = FALSE, label = NULL, gc = FALSE) [[15]] Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) [[16]] eval(expr, envir = globalenv()) [[17]] eval(expr, envir = globalenv()) [[18]] local({ { 42L stop("Woops") } }) [[19]] eval.parent(substitute(eval(quote(expr), envir))) [[20]] eval(expr, p) [[21]] eval(expr, p) [[22]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[23]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[24]] stop("Woops") [[25]] eval(quote({ { 42L stop("Woops") } }), new.env()) > message("*** backtrace( ) - implicit future ... DONE") *** backtrace( ) - implicit future ... DONE > message("*** backtrace( ) - subsetting ...") *** backtrace( ) - subsetting ... > env <- new.env() > env[["a"]] %<-% { + 42 + stop("Woops") + } [05:57:05.691] future(..., label = NULL) ... [05:57:05.691] | lazy: FALSE [05:57:05.692] | stdout: TRUE [05:57:05.692] | conditions: [n=1] 'condition' [05:57:05.692] | gc: FALSE [05:57:05.692] | earlySignal: FALSE [05:57:05.692] | getGlobalsAndPackages() ... [05:57:05.693] | : Searching for globals ... [05:57:05.701] | : . globals found: [2] '{', 'stop' [05:57:05.701] | : Searching for globals ... done [05:57:05.701] | : Resolving globals: FALSE [05:57:05.702] | : Search for packages associated with the globals ... [05:57:05.702] | : . Packages associated with globals: [1] 'base' [05:57:05.702] | : . Packages: [1] 'base' [05:57:05.702] | : Search for packages associated with the globals ... done [05:57:05.703] | : Packages after dropping 'base': [0] [05:57:05.703] | : globals: [0] [05:57:05.703] | : packages: [0] [05:57:05.703] | getGlobalsAndPackages() ... done [05:57:05.704] | run() for 'Future' () ... [05:57:05.704] | : state: 'created' [05:57:05.704] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.705] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.705] | : Using SequentialFutureBackend ... [05:57:05.705] | : . Number of futures since start: 2 (2 created, 2 launched, 2 finished) [05:57:05.705] | : . Launching futures ... [05:57:05.706] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:05.706] | : . ' , getFutureData() ... [05:57:05.706] | : . ' , ; getFutureCore() ... [05:57:05.706] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:05.706] | : . ' , ; getFutureCore() ... done [05:57:05.707] | : . ' , ; getFutureCapture() ... [05:57:05.707] | : . ' , ; getFutureCapture() ... done [05:57:05.707] | : . ' , ; getFutureContext() ... [05:57:05.707] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.707] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:05.708] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.708] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:05.708] | : . ' , ; getFutureContext() ... done [05:57:05.709] | : . ' , getFutureData() ... done [05:57:05.711] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.712] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:05.712] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.713] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.713] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.713] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:05.714] | : . ' , ; ` | New stack: [05:57:05.714] | : . ' , ; ` | List of 1 [05:57:05.714] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.714] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.714] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:05.714] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.714] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.714] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.714] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.714] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.719] | : . ' , ; ` | Old stack: [05:57:05.719] | : . ' , ; ` | List of 1 [05:57:05.719] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.719] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.719] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:05.719] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.719] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.719] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.719] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:05.719] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.719] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.719] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.719] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.724] | : . ' , ; ` | Not identical [05:57:05.724] | : . ' , ; ` | all.equal() for future ... [05:57:05.724] | : . ' , ; ` | : List of 2 [05:57:05.724] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.724] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.724] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.724] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.724] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.724] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.724] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.732] | : . ' , ; ` | all.equal() for future ... done [05:57:05.732] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:05.732] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.732] | : . ' , ; ` List of future strategies: [05:57:05.732] | : . ' , ; ` 1. sequential: [05:57:05.732] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.732] | : . ' , ; ` - tweaked: FALSE [05:57:05.732] | : . ' , ; ` - call: plan(sequential) [05:57:05.733] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.733] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.737] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.737] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.737] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.738] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:05.738] | : . ' , ; ` | : New stack: [05:57:05.738] | : . ' , ; ` | : List of 1 [05:57:05.738] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.738] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.738] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.738] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.738] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.738] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.738] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.738] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.738] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.738] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.738] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.744] | : . ' , ; ` | : Old stack: [05:57:05.744] | : . ' , ; ` | : List of 1 [05:57:05.744] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.744] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.744] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.744] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.744] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.744] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.744] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.744] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.744] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.744] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.744] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.748] | : . ' , ; ` | : Identical [05:57:05.748] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:05.748] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.748] | : . ' , ; ` | List of future strategies: [05:57:05.748] | : . ' , ; ` | 1. sequential: [05:57:05.748] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.748] | : . ' , ; ` | - tweaked: FALSE [05:57:05.748] | : . ' , ; ` | - call: plan(sequential) [05:57:05.749] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.749] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.749] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.750] | : . ' , SequentialFuture started (and completed) [05:57:05.750] | : . ' , signalConditions() ... [05:57:05.750] | : . ' , ; include = 'immediateCondition' [05:57:05.750] | : . ' , ; exclude = [05:57:05.750] | : . ' , ; resignal = FALSE [05:57:05.751] | : . ' , ; Number of conditions: 7 [05:57:05.751] | : . ' , ; int 7 [05:57:05.751] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.751] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.752] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.752] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.752] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.752] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.752] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:05.752] | : . ' , signalConditions() ... done [05:57:05.753] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:05.753] | : . Launching futures ... done [05:57:05.753] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:05.753] | : Using SequentialFutureBackend ... done [05:57:05.753] | run() for 'Future' () ... done [05:57:05.753] future(..., label = NULL) ... done > env[["b"]] %<-% { + 42 + stop("Woops") + } [05:57:05.754] future(..., label = NULL) ... [05:57:05.754] | lazy: FALSE [05:57:05.754] | stdout: TRUE [05:57:05.754] | conditions: [n=1] 'condition' [05:57:05.754] | gc: FALSE [05:57:05.755] | earlySignal: FALSE [05:57:05.755] | getGlobalsAndPackages() ... [05:57:05.755] | : Searching for globals ... [05:57:05.763] | : . globals found: [2] '{', 'stop' [05:57:05.764] | : Searching for globals ... done [05:57:05.764] | : Resolving globals: FALSE [05:57:05.764] | : Search for packages associated with the globals ... [05:57:05.765] | : . Packages associated with globals: [1] 'base' [05:57:05.765] | : . Packages: [1] 'base' [05:57:05.765] | : Search for packages associated with the globals ... done [05:57:05.766] | : Packages after dropping 'base': [0] [05:57:05.766] | : globals: [0] [05:57:05.766] | : packages: [0] [05:57:05.766] | getGlobalsAndPackages() ... done [05:57:05.767] | run() for 'Future' () ... [05:57:05.767] | : state: 'created' [05:57:05.768] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.768] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.768] | : Using SequentialFutureBackend ... [05:57:05.768] | : . Number of futures since start: 3 (3 created, 3 launched, 3 finished) [05:57:05.769] | : . Launching futures ... [05:57:05.769] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:05.769] | : . ' , getFutureData() ... [05:57:05.769] | : . ' , ; getFutureCore() ... [05:57:05.770] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:05.770] | : . ' , ; getFutureCore() ... done [05:57:05.770] | : . ' , ; getFutureCapture() ... [05:57:05.770] | : . ' , ; getFutureCapture() ... done [05:57:05.771] | : . ' , ; getFutureContext() ... [05:57:05.771] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.771] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:05.771] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.772] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:05.772] | : . ' , ; getFutureContext() ... done [05:57:05.772] | : . ' , getFutureData() ... done [05:57:05.775] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.776] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:05.776] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.776] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.777] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.777] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:05.777] | : . ' , ; ` | New stack: [05:57:05.778] | : . ' , ; ` | List of 1 [05:57:05.778] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.778] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.778] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:05.778] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.778] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.778] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.778] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.778] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.782] | : . ' , ; ` | Old stack: [05:57:05.783] | : . ' , ; ` | List of 1 [05:57:05.783] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.783] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.783] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:05.783] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.783] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.783] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.783] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:05.783] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.783] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.783] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.783] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.789] | : . ' , ; ` | Not identical [05:57:05.789] | : . ' , ; ` | all.equal() for future ... [05:57:05.789] | : . ' , ; ` | : List of 2 [05:57:05.789] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.789] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.789] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.789] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.789] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.789] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.789] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.796] | : . ' , ; ` | all.equal() for future ... done [05:57:05.796] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:05.796] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.796] | : . ' , ; ` List of future strategies: [05:57:05.796] | : . ' , ; ` 1. sequential: [05:57:05.796] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.796] | : . ' , ; ` - tweaked: FALSE [05:57:05.796] | : . ' , ; ` - call: plan(sequential) [05:57:05.797] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.797] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.800] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.800] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.801] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.801] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:05.801] | : . ' , ; ` | : New stack: [05:57:05.801] | : . ' , ; ` | : List of 1 [05:57:05.801] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.801] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.801] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.801] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.801] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.801] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.801] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.801] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.801] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.801] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.801] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.805] | : . ' , ; ` | : Old stack: [05:57:05.805] | : . ' , ; ` | : List of 1 [05:57:05.805] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.805] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.805] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.805] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.805] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.805] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.805] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.805] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.805] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.805] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.805] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.808] | : . ' , ; ` | : Identical [05:57:05.809] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:05.809] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.809] | : . ' , ; ` | List of future strategies: [05:57:05.809] | : . ' , ; ` | 1. sequential: [05:57:05.809] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.809] | : . ' , ; ` | - tweaked: FALSE [05:57:05.809] | : . ' , ; ` | - call: plan(sequential) [05:57:05.809] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.810] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.810] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.810] | : . ' , SequentialFuture started (and completed) [05:57:05.811] | : . ' , signalConditions() ... [05:57:05.811] | : . ' , ; include = 'immediateCondition' [05:57:05.811] | : . ' , ; exclude = [05:57:05.811] | : . ' , ; resignal = FALSE [05:57:05.811] | : . ' , ; Number of conditions: 7 [05:57:05.811] | : . ' , ; int 7 [05:57:05.812] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.812] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.812] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.812] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.813] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.813] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.813] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:05.813] | : . ' , signalConditions() ... done [05:57:05.813] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:05.813] | : . Launching futures ... done [05:57:05.814] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:05.814] | : Using SequentialFutureBackend ... done [05:57:05.814] | run() for 'Future' () ... done [05:57:05.814] future(..., label = NULL) ... done > calls <- backtrace(env[["b"]]) [05:57:05.815] resolved() for SequentialFuture () ... [05:57:05.815] | state: 'finished' [05:57:05.816] | run: TRUE [05:57:05.816] | result: 'FutureResult' [05:57:05.816] resolved() for SequentialFuture () ... done > print(calls) [[1]] future:::testme("backtrace") [[2]] source(file.path(path, "run.R")) [[3]] withVisible(eval(ei, envir)) [[4]] eval(ei, envir) [[5]] eval(ei, envir) [[6]] source(testme[["script"]], echo = TRUE) [[7]] withVisible(eval(ei, envir)) [[8]] eval(ei, envir) [[9]] eval(ei, envir) [[10]] env[["b"]] %<-% { 42L stop("Woops") } [[11]] futureAssignInternal(target, expr, envir = envir, substitute = FALSE) [[12]] futureAssign(name, expr, envir = envir, assign.env = assign.env, substitute = FALSE) [[13]] do.call(future::future, args = future.args, envir = envir) [[14]] (function (expr, envir = parent.frame(), substitute = TRUE, lazy = FALSE, seed = FALSE, globals = TRUE, packages = NULL, stdout = TRUE, conditions = "condition", label = NULL, gc = FALSE, earlySignal = FALSE, ...) { debug <- isTRUE(getOption("future.debug")) if (debug) { mdebugf_push("future(..., label = %s) ...", sQuoteLabel(label)) mdebugf("lazy: %s", lazy) mdebugf("stdout: %s", stdout) mdebugf("conditions: [n=%d] %s", length(conditions), commaq(conditions)) mdebugf("gc: %s", gc) mdebugf("earlySignal: %s", earlySignal) on.exit(mdebugf_pop()) } if (substitute) expr <- substitute(expr) t_start <- Sys.time() onReference <- getOption("future.globals.onReference") if (is.null(onReference)) onReference <- "ignore" if (!is.null(globals)) { gp <- getGlobalsAndPackages(expr, envir = envir, tweak = tweakExpression, globals = globals, onReference = onReference, maxSize = +Inf) expr <- gp[["expr"]] globals <- gp[["globals"]] if (length(packages) > 0 || length(gp[["packages"]]) > 0) { packages <- c(gp[["packages"]], packages) } gp <- NULL attr(globals, "already-done") <- TRUE } future <- Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) future[[".defaultLocal"]] <- !is.element("local", names(list(...))) if (isTRUE(getOption("future.journal"))) { future <- makeFutureJournal(future, event = "create", category = "overhead", start = t_start) } if (!lazy) { future <- run(future) future[["lazy"]] <- FALSE stop_if_not(inherits(future, "Future"), !future[["lazy"]]) } future })({ 42L stop("Woops") }, envir = , lazy = FALSE, seed = FALSE, globals = TRUE, packages = NULL, stdout = TRUE, conditions = "condition", earlySignal = FALSE, label = NULL, gc = FALSE) [[15]] Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) [[16]] eval(expr, envir = globalenv()) [[17]] eval(expr, envir = globalenv()) [[18]] local({ { 42L stop("Woops") } }) [[19]] eval.parent(substitute(eval(quote(expr), envir))) [[20]] eval(expr, p) [[21]] eval(expr, p) [[22]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[23]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[24]] stop("Woops") [[25]] eval(quote({ { 42L stop("Woops") } }), new.env()) > stopifnot(is.list(calls)) > lenv <- listenv::listenv() > lenv[[1]] %<-% { + 42 + stop("Woops") + } [05:57:05.820] future(..., label = NULL) ... [05:57:05.821] | lazy: FALSE [05:57:05.821] | stdout: TRUE [05:57:05.821] | conditions: [n=1] 'condition' [05:57:05.821] | gc: FALSE [05:57:05.822] | earlySignal: FALSE [05:57:05.822] | getGlobalsAndPackages() ... [05:57:05.822] | : Searching for globals ... [05:57:05.829] | : . globals found: [2] '{', 'stop' [05:57:05.830] | : Searching for globals ... done [05:57:05.830] | : Resolving globals: FALSE [05:57:05.830] | : Search for packages associated with the globals ... [05:57:05.830] | : . Packages associated with globals: [1] 'base' [05:57:05.831] | : . Packages: [1] 'base' [05:57:05.831] | : Search for packages associated with the globals ... done [05:57:05.831] | : Packages after dropping 'base': [0] [05:57:05.831] | : globals: [0] [05:57:05.831] | : packages: [0] [05:57:05.831] | getGlobalsAndPackages() ... done [05:57:05.832] | run() for 'Future' () ... [05:57:05.832] | : state: 'created' [05:57:05.832] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.832] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.832] | : Using SequentialFutureBackend ... [05:57:05.832] | : . Number of futures since start: 4 (4 created, 4 launched, 4 finished) [05:57:05.833] | : . Launching futures ... [05:57:05.833] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:05.833] | : . ' , getFutureData() ... [05:57:05.833] | : . ' , ; getFutureCore() ... [05:57:05.833] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:05.833] | : . ' , ; getFutureCore() ... done [05:57:05.833] | : . ' , ; getFutureCapture() ... [05:57:05.834] | : . ' , ; getFutureCapture() ... done [05:57:05.834] | : . ' , ; getFutureContext() ... [05:57:05.834] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.834] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:05.834] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.834] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:05.835] | : . ' , ; getFutureContext() ... done [05:57:05.835] | : . ' , getFutureData() ... done [05:57:05.836] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.837] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:05.837] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.837] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.837] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.838] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:05.838] | : . ' , ; ` | New stack: [05:57:05.838] | : . ' , ; ` | List of 1 [05:57:05.838] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.838] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.838] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:05.838] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.838] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.838] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.838] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.838] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.841] | : . ' , ; ` | Old stack: [05:57:05.841] | : . ' , ; ` | List of 1 [05:57:05.841] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.841] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.841] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:05.841] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.841] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.841] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.841] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:05.841] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.841] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.841] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.841] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.845] | : . ' , ; ` | Not identical [05:57:05.845] | : . ' , ; ` | all.equal() for future ... [05:57:05.846] | : . ' , ; ` | : List of 2 [05:57:05.846] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.846] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.846] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.846] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.846] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.846] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.846] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.854] | : . ' , ; ` | all.equal() for future ... done [05:57:05.854] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:05.854] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.854] | : . ' , ; ` List of future strategies: [05:57:05.854] | : . ' , ; ` 1. sequential: [05:57:05.854] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.854] | : . ' , ; ` - tweaked: FALSE [05:57:05.854] | : . ' , ; ` - call: plan(sequential) [05:57:05.855] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.855] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.858] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.858] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.858] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.858] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:05.859] | : . ' , ; ` | : New stack: [05:57:05.859] | : . ' , ; ` | : List of 1 [05:57:05.859] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.859] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.859] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.859] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.859] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.859] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.859] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.859] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.859] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.859] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.859] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.862] | : . ' , ; ` | : Old stack: [05:57:05.862] | : . ' , ; ` | : List of 1 [05:57:05.862] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.862] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.862] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.862] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.862] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.862] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.862] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.862] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.862] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.862] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.862] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.866] | : . ' , ; ` | : Identical [05:57:05.866] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:05.866] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.866] | : . ' , ; ` | List of future strategies: [05:57:05.866] | : . ' , ; ` | 1. sequential: [05:57:05.866] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.866] | : . ' , ; ` | - tweaked: FALSE [05:57:05.866] | : . ' , ; ` | - call: plan(sequential) [05:57:05.867] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.867] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.867] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.868] | : . ' , SequentialFuture started (and completed) [05:57:05.868] | : . ' , signalConditions() ... [05:57:05.868] | : . ' , ; include = 'immediateCondition' [05:57:05.868] | : . ' , ; exclude = [05:57:05.869] | : . ' , ; resignal = FALSE [05:57:05.869] | : . ' , ; Number of conditions: 7 [05:57:05.869] | : . ' , ; int 7 [05:57:05.869] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.869] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.870] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.870] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.870] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.870] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.870] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:05.870] | : . ' , signalConditions() ... done [05:57:05.871] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:05.871] | : . Launching futures ... done [05:57:05.871] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:05.871] | : Using SequentialFutureBackend ... done [05:57:05.871] | run() for 'Future' () ... done [05:57:05.871] future(..., label = NULL) ... done > lenv[[2]] %<-% { + 42 + stop("Woops") + } [05:57:05.872] future(..., label = NULL) ... [05:57:05.872] | lazy: FALSE [05:57:05.873] | stdout: TRUE [05:57:05.873] | conditions: [n=1] 'condition' [05:57:05.873] | gc: FALSE [05:57:05.873] | earlySignal: FALSE [05:57:05.874] | getGlobalsAndPackages() ... [05:57:05.874] | : Searching for globals ... [05:57:05.882] | : . globals found: [2] '{', 'stop' [05:57:05.882] | : Searching for globals ... done [05:57:05.883] | : Resolving globals: FALSE [05:57:05.883] | : Search for packages associated with the globals ... [05:57:05.883] | : . Packages associated with globals: [1] 'base' [05:57:05.884] | : . Packages: [1] 'base' [05:57:05.884] | : Search for packages associated with the globals ... done [05:57:05.884] | : Packages after dropping 'base': [0] [05:57:05.884] | : globals: [0] [05:57:05.885] | : packages: [0] [05:57:05.885] | getGlobalsAndPackages() ... done [05:57:05.885] | run() for 'Future' () ... [05:57:05.886] | : state: 'created' [05:57:05.886] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.886] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.886] | : Using SequentialFutureBackend ... [05:57:05.887] | : . Number of futures since start: 5 (5 created, 5 launched, 5 finished) [05:57:05.887] | : . Launching futures ... [05:57:05.887] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:05.887] | : . ' , getFutureData() ... [05:57:05.888] | : . ' , ; getFutureCore() ... [05:57:05.888] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:05.888] | : . ' , ; getFutureCore() ... done [05:57:05.888] | : . ' , ; getFutureCapture() ... [05:57:05.888] | : . ' , ; getFutureCapture() ... done [05:57:05.889] | : . ' , ; getFutureContext() ... [05:57:05.889] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.889] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:05.889] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.890] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:05.890] | : . ' , ; getFutureContext() ... done [05:57:05.890] | : . ' , getFutureData() ... done [05:57:05.893] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.893] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:05.893] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.894] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.894] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.894] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:05.894] | : . ' , ; ` | New stack: [05:57:05.895] | : . ' , ; ` | List of 1 [05:57:05.895] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.895] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.895] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:05.895] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.895] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.895] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.895] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.895] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.899] | : . ' , ; ` | Old stack: [05:57:05.899] | : . ' , ; ` | List of 1 [05:57:05.899] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.899] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.899] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:05.899] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.899] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.899] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.899] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:05.899] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.899] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.899] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.899] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.905] | : . ' , ; ` | Not identical [05:57:05.905] | : . ' , ; ` | all.equal() for future ... [05:57:05.905] | : . ' , ; ` | : List of 2 [05:57:05.905] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.905] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.905] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.905] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.905] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.905] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.905] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.914] | : . ' , ; ` | all.equal() for future ... done [05:57:05.915] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:05.915] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.915] | : . ' , ; ` List of future strategies: [05:57:05.915] | : . ' , ; ` 1. sequential: [05:57:05.915] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.915] | : . ' , ; ` - tweaked: FALSE [05:57:05.915] | : . ' , ; ` - call: plan(sequential) [05:57:05.916] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.916] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.920] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.921] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.921] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.921] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:05.921] | : . ' , ; ` | : New stack: [05:57:05.922] | : . ' , ; ` | : List of 1 [05:57:05.922] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.922] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.922] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.922] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.922] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.922] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.922] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.922] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.922] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.922] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.922] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.927] | : . ' , ; ` | : Old stack: [05:57:05.927] | : . ' , ; ` | : List of 1 [05:57:05.927] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.927] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.927] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.927] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.927] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.927] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.927] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.927] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.927] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.927] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.927] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.933] | : . ' , ; ` | : Identical [05:57:05.933] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:05.933] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.934] | : . ' , ; ` | List of future strategies: [05:57:05.934] | : . ' , ; ` | 1. sequential: [05:57:05.934] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.934] | : . ' , ; ` | - tweaked: FALSE [05:57:05.934] | : . ' , ; ` | - call: plan(sequential) [05:57:05.935] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.935] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.935] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.936] | : . ' , SequentialFuture started (and completed) [05:57:05.936] | : . ' , signalConditions() ... [05:57:05.936] | : . ' , ; include = 'immediateCondition' [05:57:05.937] | : . ' , ; exclude = [05:57:05.937] | : . ' , ; resignal = FALSE [05:57:05.937] | : . ' , ; Number of conditions: 7 [05:57:05.937] | : . ' , ; int 7 [05:57:05.938] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.938] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.939] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.939] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.939] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.939] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:05.939] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:05.940] | : . ' , signalConditions() ... done [05:57:05.940] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:05.940] | : . Launching futures ... done [05:57:05.940] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:05.941] | : Using SequentialFutureBackend ... done [05:57:05.941] | run() for 'Future' () ... done [05:57:05.941] future(..., label = NULL) ... done > calls <- backtrace(lenv[[2]]) [05:57:05.942] resolved() for SequentialFuture () ... [05:57:05.942] | state: 'finished' [05:57:05.942] | run: TRUE [05:57:05.943] | result: 'FutureResult' [05:57:05.943] resolved() for SequentialFuture () ... done > print(calls) [[1]] future:::testme("backtrace") [[2]] source(file.path(path, "run.R")) [[3]] withVisible(eval(ei, envir)) [[4]] eval(ei, envir) [[5]] eval(ei, envir) [[6]] source(testme[["script"]], echo = TRUE) [[7]] withVisible(eval(ei, envir)) [[8]] eval(ei, envir) [[9]] eval(ei, envir) [[10]] lenv[[2]] %<-% { 42L stop("Woops") } [[11]] futureAssignInternal(target, expr, envir = envir, substitute = FALSE) [[12]] futureAssign(name, expr, envir = envir, assign.env = assign.env, substitute = FALSE) [[13]] do.call(future::future, args = future.args, envir = envir) [[14]] (function (expr, envir = parent.frame(), substitute = TRUE, lazy = FALSE, seed = FALSE, globals = TRUE, packages = NULL, stdout = TRUE, conditions = "condition", label = NULL, gc = FALSE, earlySignal = FALSE, ...) { debug <- isTRUE(getOption("future.debug")) if (debug) { mdebugf_push("future(..., label = %s) ...", sQuoteLabel(label)) mdebugf("lazy: %s", lazy) mdebugf("stdout: %s", stdout) mdebugf("conditions: [n=%d] %s", length(conditions), commaq(conditions)) mdebugf("gc: %s", gc) mdebugf("earlySignal: %s", earlySignal) on.exit(mdebugf_pop()) } if (substitute) expr <- substitute(expr) t_start <- Sys.time() onReference <- getOption("future.globals.onReference") if (is.null(onReference)) onReference <- "ignore" if (!is.null(globals)) { gp <- getGlobalsAndPackages(expr, envir = envir, tweak = tweakExpression, globals = globals, onReference = onReference, maxSize = +Inf) expr <- gp[["expr"]] globals <- gp[["globals"]] if (length(packages) > 0 || length(gp[["packages"]]) > 0) { packages <- c(gp[["packages"]], packages) } gp <- NULL attr(globals, "already-done") <- TRUE } future <- Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) future[[".defaultLocal"]] <- !is.element("local", names(list(...))) if (isTRUE(getOption("future.journal"))) { future <- makeFutureJournal(future, event = "create", category = "overhead", start = t_start) } if (!lazy) { future <- run(future) future[["lazy"]] <- FALSE stop_if_not(inherits(future, "Future"), !future[["lazy"]]) } future })({ 42L stop("Woops") }, envir = , lazy = FALSE, seed = FALSE, globals = TRUE, packages = NULL, stdout = TRUE, conditions = "condition", earlySignal = FALSE, label = NULL, gc = FALSE) [[15]] Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) [[16]] eval(expr, envir = globalenv()) [[17]] eval(expr, envir = globalenv()) [[18]] local({ { 42L stop("Woops") } }) [[19]] eval.parent(substitute(eval(quote(expr), envir))) [[20]] eval(expr, p) [[21]] eval(expr, p) [[22]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[23]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[24]] stop("Woops") [[25]] eval(quote({ { 42L stop("Woops") } }), new.env()) > stopifnot(is.list(calls)) > ll <- list() > ll[[1]] <- future({ + 42 + stop("Woops") + }) [05:57:05.945] future(..., label = NULL) ... [05:57:05.946] | lazy: FALSE [05:57:05.946] | stdout: TRUE [05:57:05.946] | conditions: [n=1] 'condition' [05:57:05.946] | gc: FALSE [05:57:05.947] | earlySignal: FALSE [05:57:05.947] | getGlobalsAndPackages() ... [05:57:05.947] | : Searching for globals ... [05:57:05.956] | : . globals found: [2] '{', 'stop' [05:57:05.956] | : Searching for globals ... done [05:57:05.957] | : Resolving globals: FALSE [05:57:05.957] | : Search for packages associated with the globals ... [05:57:05.957] | : . Packages associated with globals: [1] 'base' [05:57:05.958] | : . Packages: [1] 'base' [05:57:05.958] | : Search for packages associated with the globals ... done [05:57:05.958] | : Packages after dropping 'base': [0] [05:57:05.959] | : globals: [0] [05:57:05.959] | : packages: [0] [05:57:05.959] | getGlobalsAndPackages() ... done [05:57:05.960] | run() for 'Future' () ... [05:57:05.960] | : state: 'created' [05:57:05.960] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.960] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.961] | : Using SequentialFutureBackend ... [05:57:05.961] | : . Number of futures since start: 6 (6 created, 6 launched, 6 finished) [05:57:05.961] | : . Launching futures ... [05:57:05.961] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:05.962] | : . ' , getFutureData() ... [05:57:05.962] | : . ' , ; getFutureCore() ... [05:57:05.962] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:05.962] | : . ' , ; getFutureCore() ... done [05:57:05.963] | : . ' , ; getFutureCapture() ... [05:57:05.963] | : . ' , ; getFutureCapture() ... done [05:57:05.963] | : . ' , ; getFutureContext() ... [05:57:05.964] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.964] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:05.964] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.964] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:05.964] | : . ' , ; getFutureContext() ... done [05:57:05.965] | : . ' , getFutureData() ... done [05:57:05.967] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:05.967] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:05.967] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:05.968] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.968] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.968] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:05.968] | : . ' , ; ` | New stack: [05:57:05.968] | : . ' , ; ` | List of 1 [05:57:05.968] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.968] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.968] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:05.968] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.968] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.968] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.968] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.968] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.975] | : . ' , ; ` | Old stack: [05:57:05.975] | : . ' , ; ` | List of 1 [05:57:05.975] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.975] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.975] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:05.975] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.975] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.975] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.975] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:05.975] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.975] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.975] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.975] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:05.981] | : . ' , ; ` | Not identical [05:57:05.981] | : . ' , ; ` | all.equal() for future ... [05:57:05.982] | : . ' , ; ` | : List of 2 [05:57:05.982] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.982] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:05.982] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.982] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.982] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.982] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.982] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.992] | : . ' , ; ` | all.equal() for future ... done [05:57:05.992] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:05.992] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:05.992] | : . ' , ; ` List of future strategies: [05:57:05.992] | : . ' , ; ` 1. sequential: [05:57:05.992] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:05.992] | : . ' , ; ` - tweaked: FALSE [05:57:05.992] | : . ' , ; ` - call: plan(sequential) [05:57:05.993] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:05.994] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:05.998] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.998] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:05.998] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:05.999] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:05.999] | : . ' , ; ` | : New stack: [05:57:05.999] | : . ' , ; ` | : List of 1 [05:57:05.999] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:05.999] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:05.999] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:05.999] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.999] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.999] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.999] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:05.999] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:05.999] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:05.999] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:05.999] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.005] | : . ' , ; ` | : Old stack: [05:57:06.006] | : . ' , ; ` | : List of 1 [05:57:06.006] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.006] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.006] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.006] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.006] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.006] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.006] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.006] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.006] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.006] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.006] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.012] | : . ' , ; ` | : Identical [05:57:06.012] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:06.012] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:06.013] | : . ' , ; ` | List of future strategies: [05:57:06.013] | : . ' , ; ` | 1. sequential: [05:57:06.013] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:06.013] | : . ' , ; ` | - tweaked: FALSE [05:57:06.013] | : . ' , ; ` | - call: plan(sequential) [05:57:06.013] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:06.014] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.014] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.015] | : . ' , SequentialFuture started (and completed) [05:57:06.015] | : . ' , signalConditions() ... [05:57:06.015] | : . ' , ; include = 'immediateCondition' [05:57:06.016] | : . ' , ; exclude = [05:57:06.016] | : . ' , ; resignal = FALSE [05:57:06.016] | : . ' , ; Number of conditions: 7 [05:57:06.016] | : . ' , ; int 7 [05:57:06.017] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.017] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.018] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.018] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.018] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.018] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.019] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.019] | : . ' , signalConditions() ... done [05:57:06.019] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:06.019] | : . Launching futures ... done [05:57:06.020] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:06.020] | : Using SequentialFutureBackend ... done [05:57:06.020] | run() for 'Future' () ... done [05:57:06.020] future(..., label = NULL) ... done > ll[[2]] <- future({ + 42 + stop("Woops") + }) [05:57:06.021] future(..., label = NULL) ... [05:57:06.021] | lazy: FALSE [05:57:06.021] | stdout: TRUE [05:57:06.022] | conditions: [n=1] 'condition' [05:57:06.022] | gc: FALSE [05:57:06.022] | earlySignal: FALSE [05:57:06.022] | getGlobalsAndPackages() ... [05:57:06.023] | : Searching for globals ... [05:57:06.033] | : . globals found: [2] '{', 'stop' [05:57:06.033] | : Searching for globals ... done [05:57:06.034] | : Resolving globals: FALSE [05:57:06.034] | : Search for packages associated with the globals ... [05:57:06.034] | : . Packages associated with globals: [1] 'base' [05:57:06.035] | : . Packages: [1] 'base' [05:57:06.035] | : Search for packages associated with the globals ... done [05:57:06.035] | : Packages after dropping 'base': [0] [05:57:06.035] | : globals: [0] [05:57:06.036] | : packages: [0] [05:57:06.036] | getGlobalsAndPackages() ... done [05:57:06.036] | run() for 'Future' () ... [05:57:06.036] | : state: 'created' [05:57:06.037] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.037] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.037] | : Using SequentialFutureBackend ... [05:57:06.037] | : . Number of futures since start: 7 (7 created, 7 launched, 7 finished) [05:57:06.037] | : . Launching futures ... [05:57:06.037] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:06.038] | : . ' , getFutureData() ... [05:57:06.038] | : . ' , ; getFutureCore() ... [05:57:06.038] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:06.038] | : . ' , ; getFutureCore() ... done [05:57:06.038] | : . ' , ; getFutureCapture() ... [05:57:06.038] | : . ' , ; getFutureCapture() ... done [05:57:06.038] | : . ' , ; getFutureContext() ... [05:57:06.039] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.039] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:06.039] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.039] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:06.039] | : . ' , ; getFutureContext() ... done [05:57:06.039] | : . ' , getFutureData() ... done [05:57:06.042] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.042] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:06.042] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.043] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.043] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:06.043] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:06.043] | : . ' , ; ` | New stack: [05:57:06.044] | : . ' , ; ` | List of 1 [05:57:06.044] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.044] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.044] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:06.044] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.044] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.044] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.044] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:06.044] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.048] | : . ' , ; ` | Old stack: [05:57:06.048] | : . ' , ; ` | List of 1 [05:57:06.048] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.048] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.048] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:06.048] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.048] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.048] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.048] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:06.048] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.048] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.048] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.048] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.054] | : . ' , ; ` | Not identical [05:57:06.054] | : . ' , ; ` | all.equal() for future ... [05:57:06.054] | : . ' , ; ` | : List of 2 [05:57:06.054] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.054] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:06.054] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.054] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.054] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.054] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.054] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.064] | : . ' , ; ` | all.equal() for future ... done [05:57:06.064] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:06.064] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:06.064] | : . ' , ; ` List of future strategies: [05:57:06.064] | : . ' , ; ` 1. sequential: [05:57:06.064] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:06.064] | : . ' , ; ` - tweaked: FALSE [05:57:06.064] | : . ' , ; ` - call: plan(sequential) [05:57:06.065] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:06.065] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.069] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.070] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.070] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:06.070] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:06.071] | : . ' , ; ` | : New stack: [05:57:06.071] | : . ' , ; ` | : List of 1 [05:57:06.071] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.071] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.071] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.071] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.071] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.071] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.071] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.071] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.071] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.071] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.071] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.076] | : . ' , ; ` | : Old stack: [05:57:06.077] | : . ' , ; ` | : List of 1 [05:57:06.077] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.077] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.077] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.077] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.077] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.077] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.077] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.077] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.077] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.077] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.077] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.082] | : . ' , ; ` | : Identical [05:57:06.082] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:06.082] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:06.083] | : . ' , ; ` | List of future strategies: [05:57:06.083] | : . ' , ; ` | 1. sequential: [05:57:06.083] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:06.083] | : . ' , ; ` | - tweaked: FALSE [05:57:06.083] | : . ' , ; ` | - call: plan(sequential) [05:57:06.084] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:06.084] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.084] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.085] | : . ' , SequentialFuture started (and completed) [05:57:06.085] | : . ' , signalConditions() ... [05:57:06.085] | : . ' , ; include = 'immediateCondition' [05:57:06.085] | : . ' , ; exclude = [05:57:06.086] | : . ' , ; resignal = FALSE [05:57:06.086] | : . ' , ; Number of conditions: 7 [05:57:06.086] | : . ' , ; int 7 [05:57:06.087] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.087] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.087] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.088] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.088] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.088] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.088] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.088] | : . ' , signalConditions() ... done [05:57:06.089] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:06.089] | : . Launching futures ... done [05:57:06.089] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:06.089] | : Using SequentialFutureBackend ... done [05:57:06.090] | run() for 'Future' () ... done [05:57:06.090] future(..., label = NULL) ... done > vs <- value(ll, signal = FALSE) [05:57:06.091] value() for list ... [05:57:06.091] | recursive: 0 [05:57:06.092] | reduce: FALSE [05:57:06.092] | length: 2 [05:57:06.093] | Number of remaining objects: 2 [05:57:06.093] | checking value #1: [05:57:06.093] | 'obj' is SequentialFuture [05:57:06.093] | resolved() for SequentialFuture () ... [05:57:06.093] | : state: 'finished' [05:57:06.094] | : run: TRUE [05:57:06.094] | : result: 'FutureResult' [05:57:06.094] | resolved() for SequentialFuture () ... done [05:57:06.094] | SequentialFuture #1 [05:57:06.095] | signalConditionsASAP(SequentialFuture, pos=1) ... [05:57:06.095] | : nx: 2 [05:57:06.095] | : relay: TRUE [05:57:06.095] | : stdout: TRUE [05:57:06.095] | : signal: FALSE [05:57:06.096] | : resignal: FALSE [05:57:06.096] | : force: TRUE [05:57:06.096] | : relayed: [n=2] FALSE, FALSE [05:57:06.096] | : queued futures: [n=2] FALSE, FALSE [05:57:06.096] | : until=1 [05:57:06.097] | : relaying element #1 [05:57:06.097] | : value() for SequentialFuture () ... [05:57:06.097] | : . signalConditions() ... [05:57:06.097] | : . ' include = 'immediateCondition' [05:57:06.098] | : . ' exclude = [05:57:06.098] | : . ' resignal = FALSE [05:57:06.098] | : . ' Number of conditions: 7 [05:57:06.098] | : . ' int 7 [05:57:06.099] | : . ' Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.099] | : . ' Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.100] | : . ' Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.100] | : . ' Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.100] | : . ' Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.100] | : . ' Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.100] | : . ' Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.101] | : . signalConditions() ... done [05:57:06.101] | : . relay stdout ... [05:57:06.101] | : . relay stdout ... done [05:57:06.101] | : . check for misuse ... [05:57:06.102] | : . check for misuse ... done [05:57:06.102] | : value() for SequentialFuture () ... done [05:57:06.102] | : relayed: [n=2] TRUE, FALSE [05:57:06.102] | : queued futures: [n=2] TRUE, FALSE [05:57:06.103] | signalConditionsASAP(SequentialFuture, pos=1) ... done [05:57:06.103] | value(, ...) ... [05:57:06.103] | value(, ...) ... done [05:57:06.103] | value() for SequentialFuture () ... [05:57:06.103] | : signalConditions() ... [05:57:06.103] | : . include = 'immediateCondition' [05:57:06.104] | : . exclude = [05:57:06.104] | : . resignal = FALSE [05:57:06.104] | : . Number of conditions: 7 [05:57:06.104] | : . int 7 [05:57:06.105] | : . Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.105] | : . Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.105] | : . Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.105] | : . Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.105] | : . Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.105] | : . Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.105] | : . Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.106] | : signalConditions() ... done [05:57:06.106] | : check for misuse ... [05:57:06.106] | : check for misuse ... done [05:57:06.106] | value() for SequentialFuture () ... done [05:57:06.106] | value: [05:57:06.106] | signalConditionsASAP(SequentialFuture, pos=1) ... [05:57:06.107] | : nx: 2 [05:57:06.107] | : relay: TRUE [05:57:06.109] | : stdout: TRUE [05:57:06.109] | : signal: FALSE [05:57:06.109] | : resignal: FALSE [05:57:06.109] | : force: TRUE [05:57:06.109] | : relayed: [n=2] TRUE, FALSE [05:57:06.110] | : queued futures: [n=2] TRUE, FALSE [05:57:06.110] | : until=2 [05:57:06.110] | : relaying element #2 [05:57:06.110] | : relayed: [n=2] TRUE, FALSE [05:57:06.110] | : queued futures: [n=2] TRUE, FALSE [05:57:06.110] | signalConditionsASAP(SequentialFuture, pos=1) ... done [05:57:06.111] | resolve() for SequentialFuture ... [05:57:06.111] | resolve() for SequentialFuture ... done [05:57:06.111] | length: 1 (resolved future 1) [05:57:06.111] value() for list ... done [05:57:06.111] checking value #2: [05:57:06.111] 'obj' is SequentialFuture [05:57:06.111] resolved() for SequentialFuture () ... [05:57:06.112] | state: 'finished' [05:57:06.112] | run: TRUE [05:57:06.112] | result: 'FutureResult' [05:57:06.112] resolved() for SequentialFuture () ... done [05:57:06.112] SequentialFuture #2 [05:57:06.112] signalConditionsASAP(SequentialFuture, pos=2) ... [05:57:06.113] | nx: 2 [05:57:06.113] | relay: TRUE [05:57:06.113] | stdout: TRUE [05:57:06.113] | signal: FALSE [05:57:06.113] | resignal: FALSE [05:57:06.113] | force: TRUE [05:57:06.113] | relayed: [n=2] TRUE, FALSE [05:57:06.114] | queued futures: [n=2] TRUE, FALSE [05:57:06.114] | until=2 [05:57:06.114] | relaying element #2 [05:57:06.114] | value() for SequentialFuture () ... [05:57:06.114] | : signalConditions() ... [05:57:06.114] | : . include = 'immediateCondition' [05:57:06.114] | : . exclude = [05:57:06.115] | : . resignal = FALSE [05:57:06.115] | : . Number of conditions: 7 [05:57:06.115] | : . int 7 [05:57:06.115] | : . Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.116] | : . Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.116] | : . Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.116] | : . Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.116] | : . Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.116] | : . Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.116] | : . Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.116] | : signalConditions() ... done [05:57:06.117] | : relay stdout ... [05:57:06.117] | : relay stdout ... done [05:57:06.117] | : check for misuse ... [05:57:06.117] | : check for misuse ... done [05:57:06.117] | value() for SequentialFuture () ... done [05:57:06.117] | relayed: [n=2] TRUE, TRUE [05:57:06.117] | queued futures: [n=2] TRUE, TRUE [05:57:06.118] signalConditionsASAP(SequentialFuture, pos=2) ... done [05:57:06.118] value(, ...) ... [05:57:06.118] value(, ...) ... done [05:57:06.118] value() for SequentialFuture () ... [05:57:06.118] | signalConditions() ... [05:57:06.118] | : include = 'immediateCondition' [05:57:06.119] | : exclude = [05:57:06.119] | : resignal = FALSE [05:57:06.119] | : Number of conditions: 7 [05:57:06.119] | : int 7 [05:57:06.119] | : Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.120] | : Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.120] | : Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.120] | : Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.120] | : Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.120] | : Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.120] | : Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.121] | signalConditions() ... done [05:57:06.121] | check for misuse ... [05:57:06.121] | check for misuse ... done [05:57:06.121] value() for SequentialFuture () ... done [05:57:06.121] value: [05:57:06.121] signalConditionsASAP(SequentialFuture, pos=2) ... [05:57:06.121] | nx: 2 [05:57:06.121] | relay: TRUE [05:57:06.122] | stdout: TRUE [05:57:06.122] | signal: FALSE [05:57:06.122] | resignal: FALSE [05:57:06.122] | force: TRUE [05:57:06.122] | relayed: [n=2] TRUE, TRUE [05:57:06.122] | queued futures: [n=2] TRUE, TRUE [05:57:06.122] | until=2 [05:57:06.123] | relayed: [n=2] TRUE, TRUE [05:57:06.123] | queued futures: [n=2] TRUE, TRUE [05:57:06.123] signalConditionsASAP(SequentialFuture, pos=2) ... done [05:57:06.123] resolve() for SequentialFuture ... [05:57:06.123] resolve() for SequentialFuture ... done [05:57:06.123] length: 0 (resolved future 2) [05:57:06.124] Relaying remaining futures ... [05:57:06.124] | signalConditionsASAP(NULL, pos=0) ... [05:57:06.124] | : nx: 2 [05:57:06.124] | : relay: TRUE [05:57:06.124] | : stdout: TRUE [05:57:06.124] | : signal: FALSE [05:57:06.124] | : resignal: FALSE [05:57:06.125] | : force: TRUE [05:57:06.125] | : relayed: [n=2] TRUE, TRUE [05:57:06.125] | : queued futures: [n=2] TRUE, TRUE - flush all [05:57:06.125] | : relayed: [n=2] TRUE, TRUE [05:57:06.125] | : queued futures: [n=2] TRUE, TRUE [05:57:06.125] | signalConditionsASAP(NULL, pos=0) ... done [05:57:06.126] Relaying remaining futures ... done > calls <- backtrace(ll[[2]]) [05:57:06.126] resolved() for SequentialFuture () ... [05:57:06.126] | state: 'finished' [05:57:06.127] | run: TRUE [05:57:06.127] | result: 'FutureResult' [05:57:06.127] resolved() for SequentialFuture () ... done > print(calls) [[1]] future:::testme("backtrace") [[2]] source(file.path(path, "run.R")) [[3]] withVisible(eval(ei, envir)) [[4]] eval(ei, envir) [[5]] eval(ei, envir) [[6]] source(testme[["script"]], echo = TRUE) [[7]] withVisible(eval(ei, envir)) [[8]] eval(ei, envir) [[9]] eval(ei, envir) [[10]] future({ 42L stop("Woops") }) [[11]] Future(expr, substitute = FALSE, envir = envir, lazy = TRUE, seed = seed, globals = globals, packages = packages, stdout = stdout, conditions = conditions, earlySignal = earlySignal, label = label, gc = gc, onReference = onReference, ...) [[12]] eval(expr, envir = globalenv()) [[13]] eval(expr, envir = globalenv()) [[14]] local({ { 42L stop("Woops") } }) [[15]] eval.parent(substitute(eval(quote(expr), envir))) [[16]] eval(expr, p) [[17]] eval(expr, p) [[18]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[19]] eval(quote({ { 42L stop("Woops") } }), new.env()) [[20]] stop("Woops") [[21]] eval(quote({ { 42L stop("Woops") } }), new.env()) > stopifnot(is.list(calls)) > message("*** backtrace( ) - subsetting ... DONE") *** backtrace( ) - subsetting ... DONE > message("*** backtrace( ) - exceptions ...") *** backtrace( ) - exceptions ... > message("- No condition ...") - No condition ... > f <- future(42) [05:57:06.128] future(..., label = NULL) ... [05:57:06.128] | lazy: FALSE [05:57:06.129] | stdout: TRUE [05:57:06.129] | conditions: [n=1] 'condition' [05:57:06.129] | gc: FALSE [05:57:06.129] | earlySignal: FALSE [05:57:06.129] | getGlobalsAndPackages() ... [05:57:06.130] | : Searching for globals ... [05:57:06.131] | : . globals found: [0] [05:57:06.131] | : Searching for globals ... done [05:57:06.131] | : globals: [0] [05:57:06.131] | : packages: [0] [05:57:06.132] | getGlobalsAndPackages() ... done [05:57:06.132] | run() for 'Future' () ... [05:57:06.132] | : state: 'created' [05:57:06.132] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.132] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.133] | : Using SequentialFutureBackend ... [05:57:06.133] | : . Number of futures since start: 8 (8 created, 8 launched, 8 finished) [05:57:06.133] | : . Launching futures ... [05:57:06.133] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:06.133] | : . ' , getFutureData() ... [05:57:06.133] | : . ' , ; getFutureCore() ... [05:57:06.134] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:06.134] | : . ' , ; getFutureCore() ... done [05:57:06.134] | : . ' , ; getFutureCapture() ... [05:57:06.134] | : . ' , ; getFutureCapture() ... done [05:57:06.134] | : . ' , ; getFutureContext() ... [05:57:06.134] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.135] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:06.135] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.135] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:06.135] | : . ' , ; getFutureContext() ... done [05:57:06.136] | : . ' , getFutureData() ... done [05:57:06.138] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.138] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:06.139] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.139] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.139] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:06.140] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:06.140] | : . ' , ; ` | New stack: [05:57:06.140] | : . ' , ; ` | List of 1 [05:57:06.140] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.140] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.140] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:06.140] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.140] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.140] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.140] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:06.140] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.145] | : . ' , ; ` | Old stack: [05:57:06.145] | : . ' , ; ` | List of 1 [05:57:06.145] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.145] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.145] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:06.145] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.145] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.145] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.145] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:06.145] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.145] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.145] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.145] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.150] | : . ' , ; ` | Not identical [05:57:06.150] | : . ' , ; ` | all.equal() for future ... [05:57:06.151] | : . ' , ; ` | : List of 2 [05:57:06.151] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.151] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:06.151] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.151] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.151] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.151] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.151] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.159] | : . ' , ; ` | all.equal() for future ... done [05:57:06.159] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:06.160] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:06.160] | : . ' , ; ` List of future strategies: [05:57:06.160] | : . ' , ; ` 1. sequential: [05:57:06.160] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:06.160] | : . ' , ; ` - tweaked: FALSE [05:57:06.160] | : . ' , ; ` - call: plan(sequential) [05:57:06.161] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:06.161] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.164] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.164] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.165] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:06.165] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:06.165] | : . ' , ; ` | : New stack: [05:57:06.165] | : . ' , ; ` | : List of 1 [05:57:06.165] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.165] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.165] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.165] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.165] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.165] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.165] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.165] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.165] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.165] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.165] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.170] | : . ' , ; ` | : Old stack: [05:57:06.171] | : . ' , ; ` | : List of 1 [05:57:06.171] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.171] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.171] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.171] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.171] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.171] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.171] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.171] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.171] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.171] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.171] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.176] | : . ' , ; ` | : Identical [05:57:06.176] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:06.176] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:06.176] | : . ' , ; ` | List of future strategies: [05:57:06.176] | : . ' , ; ` | 1. sequential: [05:57:06.176] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:06.176] | : . ' , ; ` | - tweaked: FALSE [05:57:06.176] | : . ' , ; ` | - call: plan(sequential) [05:57:06.177] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:06.177] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.178] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.178] | : . ' , SequentialFuture started (and completed) [05:57:06.179] | : . ' , signalConditions() ... [05:57:06.179] | : . ' , ; include = 'immediateCondition' [05:57:06.179] | : . ' , ; exclude = [05:57:06.179] | : . ' , ; resignal = FALSE [05:57:06.179] | : . ' , ; Number of conditions: 6 [05:57:06.180] | : . ' , ; int 6 [05:57:06.180] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.180] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.181] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.181] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.181] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.181] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.182] | : . ' , signalConditions() ... done [05:57:06.182] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:06.182] | : . Launching futures ... done [05:57:06.182] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:06.183] | : Using SequentialFutureBackend ... done [05:57:06.183] | run() for 'Future' () ... done [05:57:06.183] future(..., label = NULL) ... done > res <- tryCatch(backtrace(f), error = identity) [05:57:06.184] resolved() for SequentialFuture () ... [05:57:06.184] | state: 'finished' [05:57:06.184] | run: TRUE [05:57:06.184] | result: 'FutureResult' [05:57:06.184] resolved() for SequentialFuture () ... done > print(res) > stopifnot(inherits(res, "error")) > message("- No call stack ...") - No call stack ... > f <- future({ + 42 + stop("Woops") + }) [05:57:06.185] future(..., label = NULL) ... [05:57:06.186] | lazy: FALSE [05:57:06.186] | stdout: TRUE [05:57:06.186] | conditions: [n=1] 'condition' [05:57:06.186] | gc: FALSE [05:57:06.186] | earlySignal: FALSE [05:57:06.187] | getGlobalsAndPackages() ... [05:57:06.187] | : Searching for globals ... [05:57:06.195] | : . globals found: [2] '{', 'stop' [05:57:06.196] | : Searching for globals ... done [05:57:06.196] | : Resolving globals: FALSE [05:57:06.196] | : Search for packages associated with the globals ... [05:57:06.196] | : . Packages associated with globals: [1] 'base' [05:57:06.197] | : . Packages: [1] 'base' [05:57:06.197] | : Search for packages associated with the globals ... done [05:57:06.197] | : Packages after dropping 'base': [0] [05:57:06.198] | : globals: [0] [05:57:06.198] | : packages: [0] [05:57:06.198] | getGlobalsAndPackages() ... done [05:57:06.198] | run() for 'Future' () ... [05:57:06.199] | : state: 'created' [05:57:06.199] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.199] | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.199] | : Using SequentialFutureBackend ... [05:57:06.200] | : . Number of futures since start: 9 (9 created, 9 launched, 9 finished) [05:57:06.200] | : . Launching futures ... [05:57:06.200] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... [05:57:06.200] | : . ' , getFutureData() ... [05:57:06.200] | : . ' , ; getFutureCore() ... [05:57:06.201] | : . ' , ; ` Packages needed by the future expression (n = 0): [05:57:06.201] | : . ' , ; getFutureCore() ... done [05:57:06.201] | : . ' , ; getFutureCapture() ... [05:57:06.201] | : . ' , ; getFutureCapture() ... done [05:57:06.202] | : . ' , ; getFutureContext() ... [05:57:06.202] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.202] | : . ' , ; ` | Getting stack without first backend: [n=0] [05:57:06.202] | : . ' , ; ` plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.202] | : . ' , ; ` Packages needed by future backend (n = 0): [05:57:06.203] | : . ' , ; getFutureContext() ... done [05:57:06.203] | : . ' , getFutureData() ... done [05:57:06.205] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.205] | : . ' , ; Getting full stack: [n=1] 'sequential', 'uniprocess', 'future', 'function' [05:57:06.206] | : . ' , plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.206] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.206] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:06.207] | : . ' , ; ` all.equal() for FutureStrategyList ... [05:57:06.207] | : . ' , ; ` | New stack: [05:57:06.207] | : . ' , ; ` | List of 1 [05:57:06.207] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.207] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.207] | : . ' , ; ` | ..- attr(*, "init")= logi TRUE [05:57:06.207] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.207] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.207] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.207] | : . ' , ; ` | ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:06.207] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.211] | : . ' , ; ` | Old stack: [05:57:06.211] | : . ' , ; ` | List of 1 [05:57:06.211] | : . ' , ; ` | $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.211] | : . ' , ; ` | ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.211] | : . ' , ; ` | ..- attr(*, "init")= chr "done" [05:57:06.211] | : . ' , ; ` | ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.211] | : . ' , ; ` | .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.211] | : . ' , ; ` | ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.211] | : . ' , ; ` | ..- attr(*, "call")= language plan(sequential) [05:57:06.211] | : . ' , ; ` | ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.211] | : . ' , ; ` | .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.211] | : . ' , ; ` | .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.211] | : . ' , ; ` | - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.216] | : . ' , ; ` | Not identical [05:57:06.217] | : . ' , ; ` | all.equal() for future ... [05:57:06.217] | : . ' , ; ` | : List of 2 [05:57:06.217] | : . ' , ; ` | : $ target :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "init")= logi TRUE [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.217] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "call")= language plan(strategiesR, .cleanup = FALSE, .init = FALSE) [05:57:06.217] | : . ' , ; ` | : $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.217] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.217] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.217] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.217] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.228] | : . ' , ; ` | all.equal() for future ... done [05:57:06.228] | : . ' , ; ` all.equal() for FutureStrategyList ... done [05:57:06.228] | : . ' , ; ` plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:06.229] | : . ' , ; ` List of future strategies: [05:57:06.229] | : . ' , ; ` 1. sequential: [05:57:06.229] | : . ' , ; ` - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:06.229] | : . ' , ; ` - tweaked: FALSE [05:57:06.229] | : . ' , ; ` - call: plan(sequential) [05:57:06.230] | : . ' , ; plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:06.230] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.233] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.234] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... [05:57:06.234] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... [05:57:06.234] | : . ' , ; ` | all.equal() for FutureStrategyList ... [05:57:06.234] | : . ' , ; ` | : New stack: [05:57:06.235] | : . ' , ; ` | : List of 1 [05:57:06.235] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.235] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.235] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.235] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.235] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.235] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.235] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.235] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.235] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.235] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.235] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.240] | : . ' , ; ` | : Old stack: [05:57:06.240] | : . ' , ; ` | : List of 1 [05:57:06.240] | : . ' , ; ` | : $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.240] | : . ' , ; ` | : ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.240] | : . ' , ; ` | : ..- attr(*, "init")= chr "done" [05:57:06.240] | : . ' , ; ` | : ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.240] | : . ' , ; ` | : .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.240] | : . ' , ; ` | : ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.240] | : . ' , ; ` | : ..- attr(*, "call")= language plan(sequential) [05:57:06.240] | : . ' , ; ` | : ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.240] | : . ' , ; ` | : .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.240] | : . ' , ; ` | : .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.240] | : . ' , ; ` | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.245] | : . ' , ; ` | : Identical [05:57:06.245] | : . ' , ; ` | all.equal() for FutureStrategyList ... done [05:57:06.245] | : . ' , ; ` | plan(): Skip setting new future backend stack because it is the same as the current one: [05:57:06.246] | : . ' , ; ` | List of future strategies: [05:57:06.246] | : . ' , ; ` | 1. sequential: [05:57:06.246] | : . ' , ; ` | - args: function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame(), workers = "") [05:57:06.246] | : . ' , ; ` | - tweaked: FALSE [05:57:06.246] | : . ' , ; ` | - call: plan(sequential) [05:57:06.246] | : . ' , ; ` plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = FALSE, init = FALSE) ... done [05:57:06.247] | : . ' , ; plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.247] | : . ' , plan(, .skip = FALSE, .cleanup = FALSE, .init = FALSE) ... done [05:57:06.247] | : . ' , SequentialFuture started (and completed) [05:57:06.248] | : . ' , signalConditions() ... [05:57:06.248] | : . ' , ; include = 'immediateCondition' [05:57:06.248] | : . ' , ; exclude = [05:57:06.248] | : . ' , ; resignal = FALSE [05:57:06.249] | : . ' , ; Number of conditions: 7 [05:57:06.249] | : . ' , ; int 7 [05:57:06.249] | : . ' , ; Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.250] | : . ' , ; Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.250] | : . ' , ; Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.250] | : . ' , ; Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.250] | : . ' , ; Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.250] | : . ' , ; Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.251] | : . ' , ; Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.251] | : . ' , signalConditions() ... done [05:57:06.251] | : . ' launchFuture() for 'SequentialFutureBackend', 'FutureBackend', 'environment' ... done [05:57:06.251] | : . Launching futures ... done [05:57:06.252] | : . Future launched: 'SequentialFuture', 'UniprocessFuture', 'Future' [05:57:06.252] | : Using SequentialFutureBackend ... done [05:57:06.252] | run() for 'Future' () ... done [05:57:06.252] future(..., label = NULL) ... done > v <- value(f, signal = FALSE) [05:57:06.253] value() for SequentialFuture () ... [05:57:06.253] | signalConditions() ... [05:57:06.253] | : include = 'immediateCondition' [05:57:06.253] | : exclude = [05:57:06.254] | : resignal = FALSE [05:57:06.254] | : Number of conditions: 7 [05:57:06.254] | : int 7 [05:57:06.255] | : Condition #1 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.255] | : Condition #2 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.255] | : Condition #3 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.255] | : Condition #4 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.256] | : Condition #5 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.256] | : Condition #6 (class: 'simpleMessage', 'message', 'condition'): [05:57:06.256] | : Condition #7 (class: 'simpleError', 'error', 'condition'): [05:57:06.256] | signalConditions() ... done [05:57:06.256] | relay stdout ... [05:57:06.257] | relay stdout ... done [05:57:06.257] | check for misuse ... [05:57:06.257] | check for misuse ... done [05:57:06.257] value() for SequentialFuture () ... done > if (availableCores() >= 2) { + message("- Non-resolved future ...") + plan(multisession, workers = 2) + message("- plan set") + f <- .... [TRUNCATED] - Non-resolved future ... [05:57:06.260] plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.262] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... [05:57:06.262] | : all.equal() for FutureStrategyList ... [05:57:06.262] | : . New stack: [05:57:06.262] | : . List of 1 [05:57:06.262] | : . $ :function (..., workers = 2L, envir = parent.frame()) [05:57:06.262] | : . ..- attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ... [05:57:06.262] | : . ..- attr(*, "init")= logi TRUE [05:57:06.262] | : . ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, [05:57:06.262] | : . gc = FALSE, earlySignal = FALSE, ...) [05:57:06.262] | : . .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.262] | : . ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.262] | : . ..- attr(*, "untweakable")= chr "persistent" [05:57:06.262] | : . ..- attr(*, "tweaks")=List of 1 [05:57:06.262] | : . .. ..$ workers: int 2 [05:57:06.262] | : . ..- attr(*, "call")= language plan(multisession, workers = 2L) [05:57:06.262] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.268] | : . Old stack: [05:57:06.268] | : . List of 1 [05:57:06.268] | : . $ :function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.268] | : . ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.268] | : . ..- attr(*, "init")= chr "done" [05:57:06.268] | : . ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.268] | : . .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.268] | : . ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.268] | : . ..- attr(*, "call")= language plan(sequential) [05:57:06.268] | : . ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.268] | : . .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.268] | : . .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.268] | : . - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.274] | : . Not identical [05:57:06.274] | : . all.equal() for future ... [05:57:06.274] | : . ' List of 2 [05:57:06.274] | : . ' $ target :function (..., workers = 2L, envir = parent.frame()) [05:57:06.274] | : . ' ..- attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ... [05:57:06.274] | : . ' ..- attr(*, "init")= logi TRUE [05:57:06.274] | : . ' ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, [05:57:06.274] | : . ' gc = FALSE, earlySignal = FALSE, ...) [05:57:06.274] | : . ' .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.274] | : . ' ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.274] | : . ' ..- attr(*, "untweakable")= chr "persistent" [05:57:06.274] | : . ' ..- attr(*, "tweaks")=List of 1 [05:57:06.274] | : . ' .. ..$ workers: int 2 [05:57:06.274] | : . ' ..- attr(*, "call")= language plan(multisession, workers = 2L) [05:57:06.274] | : . ' $ current:function (..., gc = FALSE, earlySignal = FALSE, envir = parent.frame()) [05:57:06.274] | : . ' ..- attr(*, "class")= chr [1:4] "sequential" "uniprocess" "future" "function" [05:57:06.274] | : . ' ..- attr(*, "init")= chr "done" [05:57:06.274] | : . ' ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.274] | : . ' .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.274] | : . ' ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.274] | : . ' ..- attr(*, "call")= language plan(sequential) [05:57:06.274] | : . ' ..- attr(*, "backend")=Classes 'SequentialFutureBackend', 'FutureBackend', 'environment' [05:57:06.274] | : . ' .. ..- attr(*, "factory")=function (..., maxSizeOfObjects = +Inf) [05:57:06.274] | : . ' .. .. ..- attr(*, "tweakable")= chr [1:5] "maxSizeOfObjects" "earlySignal" "gc" "interrupts" ... [05:57:06.284] | : . ' Formals differ [05:57:06.285] | : . all.equal() for future ... done [05:57:06.285] | : . Future strategies differ at level 1 [05:57:06.285] | : all.equal() for FutureStrategyList ... done [05:57:06.285] | : plan(): Setting new future backend stack: [05:57:06.286] | : List of future strategies: [05:57:06.286] | : 1. multisession: [05:57:06.286] | : - args: function (..., workers = 2L, envir = parent.frame()) [05:57:06.286] | : - tweaked: TRUE [05:57:06.286] | : - call: plan(multisession, workers = 2L) [05:57:06.286] | : List of 1 [05:57:06.286] | : $ :function (..., workers = 2L, envir = parent.frame()) [05:57:06.286] | : ..- attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ... [05:57:06.286] | : ..- attr(*, "init")= logi TRUE [05:57:06.286] | : ..- attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, [05:57:06.286] | : gc = FALSE, earlySignal = FALSE, ...) [05:57:06.286] | : .. ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.286] | : ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.286] | : ..- attr(*, "untweakable")= chr "persistent" [05:57:06.286] | : ..- attr(*, "tweaks")=List of 1 [05:57:06.286] | : .. ..$ workers: int 2 [05:57:06.286] | : ..- attr(*, "call")= language plan(multisession, workers = 2L) [05:57:06.286] | : - attr(*, "class")= chr [1:2] "FutureStrategyList" "list" [05:57:06.292] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... [05:57:06.292] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:06.293] | : . ' Getting current ("next") strategy: 'FutureStrategy', 'sequential', 'uniprocess', 'future', 'function' [05:57:06.293] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:06.293] | : . Legacy shutdown of cluster workers ... [05:57:06.294] | : . ' Stopping existing cluster ... [05:57:06.294] | : . ' , No pre-existing cluster. Skipping [05:57:06.294] | : . ' Stopping existing cluster ... done [05:57:06.294] | : . Legacy shutdown of cluster workers ... done [05:57:06.295] | : plan(): plan_cleanup('sequential', 'uniprocess', 'future', 'function', cleanup = NA) ... done [05:57:06.295] | : plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... [05:57:06.295] | : . function (..., workers = 2L, envir = parent.frame()) [05:57:06.295] | : . - attr(*, "class")= chr [1:6] "tweaked" "multisession" "cluster" "multiprocess" ... [05:57:06.295] | : . - attr(*, "init")= logi TRUE [05:57:06.295] | : . - attr(*, "factory")=function (workers = availableCores(), rscript_libs = .libPaths(), interrupts = TRUE, [05:57:06.295] | : . gc = FALSE, earlySignal = FALSE, ...) [05:57:06.295] | : . ..- attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.295] | : . - attr(*, "tweakable")= chr [1:11] "workers" "rscript_libs" "interrupts" "gc" ... [05:57:06.295] | : . - attr(*, "untweakable")= chr "persistent" [05:57:06.295] | : . - attr(*, "tweaks")=List of 1 [05:57:06.295] | : . ..$ workers: int 2 [05:57:06.295] | : . - attr(*, "call")= language plan(multisession, workers = 2L) [05:57:06.300] | : . init: TRUE [05:57:06.300] | : . makeFutureBackend() ... [05:57:06.300] | : . ' Backend function: <'NULL'> [05:57:06.301] | : . ' Evaluator tweak arguments: [n=1] [05:57:06.301] | : . ' List of 1 [05:57:06.301] | : . ' $ workers: int 2 [05:57:06.302] | : . ' Evaluator formal arguments: [n=1] [05:57:06.302] | : . ' List of 1 [05:57:06.302] | : . ' $ workers: int 2 [05:57:06.303] | : . ' Backend factory arguments: [n=1] [05:57:06.303] | : . ' Dotted pair list of 1 [05:57:06.303] | : . ' $ workers: int 2 [05:57:06.304] | : . ' MultisessionFutureBackend(workers = , interrupts = TRUE, ...) ... [05:57:06.305] | : . ' , Arguments: [05:57:06.305] | : . ' , List of 5 [05:57:06.305] | : . ' , $ workers : int 2 [05:57:06.305] | : . ' , $ rscript_libs: chr [1:2] "D:/temp/2025_06_05_05_55_16_20588/RtmpCKyFxh/RLIBS_1418c4def7e89" "D:/RCompile/recent/R/library" [05:57:06.305] | : . ' , $ interrupts : logi TRUE [05:57:06.305] | : . ' , $ gc : logi FALSE [05:57:06.305] | : . ' , $ earlySignal : logi FALSE [05:57:06.308] | : . ' , ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ... [05:57:06.309] | : . ' , ; workers: 2 [05:57:06.309] | : . ' , ; getCluster() ... [05:57:06.309] | : . ' , ; getCluster() ... done [05:57:06.309] | : . ' , ; Stopping existing cluster ... [05:57:06.309] | : . ' , ; ` No pre-existing cluster. Skipping [05:57:06.310] | : . ' , ; Stopping existing cluster ... done [05:57:06.310] | : . ' , ; Starting new cluster ... [05:57:06.310] | : . ' , ; ` makeCluster(workers, ...) ... [05:57:06.310] | : . ' , ; ` | Arguments: [05:57:06.311] | : . ' , ; ` | List of 2 [05:57:06.311] | : . ' , ; ` | $ : int 2 [05:57:06.311] | : . ' , ; ` | $ rscript_libs: chr [1:2] "D:/temp/2025_06_05_05_55_16_20588/RtmpCKyFxh/RLIBS_1418c4def7e89" "D:/RCompile/recent/R/library" [05:57:06.312] | : . ' , ; ` | .makeCluster() ... [05:57:06.312] | : . ' , ; ` | : workers: '2' [05:57:06.313] | : . ' , ; ` | : R_FUTURE_PLAN: NA [05:57:06.313] | : . ' , ; ` | : parallelly::makeClusterPSOCK() arguments: [05:57:06.313] | : . ' , ; ` | : List of 2 [05:57:06.313] | : . ' , ; ` | : $ : int 2 [05:57:06.313] | : . ' , ; ` | : $ rscript_libs: chr [1:2] "D:/temp/2025_06_05_05_55_16_20588/RtmpCKyFxh/RLIBS_1418c4def7e89" "D:/RCompile/recent/R/library" [05:57:07.242] | : . ' , ; ` | : Generated cluster UUID [05:57:07.242] | : . ' , ; ` | : Cluster UUID: '0339a486da8ccfc6abc9c85ecf3ab757' [05:57:07.243] | : . ' , ; ` | : Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-06-04 r88278 ucrt), platform x86_64-w64-mingw32) [05:57:07.246] | : . ' , ; ` | .makeCluster() ... done [05:57:07.246] | : . ' , ; ` | Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-06-04 r88278 ucrt), platform x86_64-w64-mingw32) [05:57:07.249] | : . ' , ; ` makeCluster(workers, ...) ... done [05:57:07.249] | : . ' , ; ` Number of workers: 2 [05:57:07.249] | : . ' , ; ` Workers UUID: '0339a486da8ccfc6abc9c85ecf3ab757' [05:57:07.250] | : . ' , ; Starting new cluster ... done [05:57:07.250] | : . ' , ClusterFutureBackend(..., persistent = FALSE, gc = FALSE, earlySignal = FALSE) ... done [05:57:07.250] | : . ' , Backend: <'MultisessionFutureBackend', 'ClusterFutureBackend', 'MultiprocessFutureBackend', 'FutureBackend', 'environment'> [05:57:07.251] | : . ' MultisessionFutureBackend(workers = , interrupts = TRUE, ...) ... done [05:57:07.251] | : . makeFutureBackend() ... done [05:57:07.251] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:07.252] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:07.252] | : . plan(): nbrOfWorkers() = 2 [05:57:07.252] | : plan(): plan_init() of 'tweaked', 'multisession', 'cluster', 'multiprocess', 'future', 'function' ... done [05:57:07.252] | plan(): plan_set(<1 strategies>, skip = FALSE, cleanup = NA, init = TRUE) ... done - plan set [05:57:07.253] | future(..., label = NULL) ... [05:57:07.253] | : lazy: FALSE [05:57:07.253] | : stdout: TRUE [05:57:07.253] | : conditions: [n=1] 'condition' [05:57:07.254] | : gc: FALSE [05:57:07.254] | : earlySignal: FALSE [05:57:07.254] | : getGlobalsAndPackages() ... [05:57:07.254] | : . Searching for globals ... [05:57:07.270] | : . ' globals found: [3] '{', 'Sys.sleep', 'stop' [05:57:07.271] | : . Searching for globals ... done [05:57:07.271] | : . Resolving globals: FALSE [05:57:07.271] | : . Search for packages associated with the globals ... [05:57:07.272] | : . ' Packages associated with globals: [1] 'base' [05:57:07.272] | : . ' Packages: [1] 'base' [05:57:07.273] | : . Search for packages associated with the globals ... done [05:57:07.273] | : . Packages after dropping 'base': [0] [05:57:07.273] | : . globals: [0] [05:57:07.273] | : . packages: [0] [05:57:07.274] | : getGlobalsAndPackages() ... done [05:57:07.274] | : run() for 'Future' () ... [05:57:07.274] | : . state: 'created' [05:57:07.275] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:07.275] | : . plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:07.275] | : . Using MultisessionFutureBackend ... [05:57:07.275] | : . ' Number of futures since start: 0 (0 created, 0 launched, 0 finished) [05:57:07.276] | : . ' Launching futures ... [05:57:07.276] | : . ' , launchFuture() for ClusterFutureBackend ... [05:57:07.277] | : . ' , ; Workers: [n=2] [05:57:07.277] | : . ' , ; Socket cluster with 2 nodes where 2 nodes are on host 'localhost' (R Under development (unstable) (2025-06-04 r88278 ucrt), platform x86_64-w64-mingw32) [05:57:07.280] | : . ' , ; FutureRegistry: 'workers-0339a486da8ccfc6abc9c85ecf3ab757' [05:57:07.280] | : . ' , ; requestWorker() ... [05:57:07.280] | : . ' , ; ` requestNode() ... [05:57:07.281] | : . ' , ; ` | Number of workers: 2 [05:57:07.281] | : . ' , ; ` | Polling for a free worker ... [05:57:07.281] | : . ' , ; ` | : FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'list', earlySignal = 0) ... [05:57:07.281] | : . ' , ; ` | : . Created empty registry 'workers-0339a486da8ccfc6abc9c85ecf3ab757' [05:57:07.282] | : . ' , ; ` | : . Listing all futures [05:57:07.282] | : . ' , ; ` | : . Number of registered futures: 0 [05:57:07.282] | : . ' , ; ` | : FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'list', earlySignal = 0) ... done [05:57:07.282] | : . ' , ; ` | : Total time: 0 [05:57:07.283] | : . ' , ; ` | Polling for a free worker ... done [05:57:07.283] | : . ' , ; ` | FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'list', earlySignal = 0) ... [05:57:07.283] | : . ' , ; ` | : Listing all futures [05:57:07.283] | : . ' , ; ` | : Number of registered futures: 0 [05:57:07.284] | : . ' , ; ` | FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'list', earlySignal = 0) ... done [05:57:07.284] | : . ' , ; ` | avail: [n=2] '1', '2' [05:57:07.284] | : . ' , ; ` | Index of first available worker: 1 [05:57:07.284] | : . ' , ; ` | Validate that the worker is functional ... [05:57:07.494] | : . ' , ; ` | : Worker is functional [05:57:07.495] | : . ' , ; ` | : FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'list', earlySignal = 0) ... [05:57:07.495] | : . ' , ; ` | : . Listing all futures [05:57:07.495] | : . ' , ; ` | : . Number of registered futures: 0 [05:57:07.496] | : . ' , ; ` | : FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'list', earlySignal = 0) ... done [05:57:07.496] | : . ' , ; ` | Validate that the worker is functional ... done [05:57:07.496] | : . ' , ; ` requestNode() ... done [05:57:07.497] | : . ' , ; ` cluster node index: 1 [05:57:07.497] | : . ' , ; requestWorker() ... done [05:57:07.497] | : . ' , ; eraseGlobalEnvironment() ... [05:57:07.498] | : . ' , ; eraseGlobalEnvironment() ... done [05:57:07.498] | : . ' , ; launchFuture() ... [05:57:07.499] | : . ' , ; ` cluster node index: 1 [05:57:07.499] | : . ' , ; ` getFutureData() ... [05:57:07.499] | : . ' , ; ` | getFutureCore() ... [05:57:07.499] | : . ' , ; ` | : Packages needed by the future expression (n = 0): [05:57:07.500] | : . ' , ; ` | getFutureCore() ... done [05:57:07.500] | : . ' , ; ` | getFutureCapture() ... [05:57:07.500] | : . ' , ; ` | getFutureCapture() ... done [05:57:07.501] | : . ' , ; ` | getFutureContext() ... [05:57:07.501] | : . ' , ; ` | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... [05:57:07.501] | : . ' , ; ` | : . Getting stack without first backend: [n=0] [05:57:07.501] | : . ' , ; ` | : plan(, .skip = FALSE, .cleanup = NA, .init = TRUE) ... done [05:57:07.502] | : . ' , ; ` | : Packages needed by future backend (n = 0): [05:57:07.502] | : . ' , ; ` | getFutureContext() ... done [05:57:07.502] | : . ' , ; ` getFutureData() ... done [05:57:07.503] | : . ' , ; ` FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'add', earlySignal = 0) ... [05:57:07.504] | : . ' , ; ` | Appended future to position #1 [05:57:07.504] | : . ' , ; ` | Number of registered futures: 1 [05:57:07.504] | : . ' , ; ` FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'add', earlySignal = 0) ... done [05:57:07.504] | : . ' , ; launchFuture() ... done [05:57:07.505] | : . ' , ; MultisessionFuture started [05:57:07.505] | : . ' , launchFuture() for ClusterFutureBackend ... done [05:57:07.505] | : . ' Launching futures ... done [05:57:07.505] | : . ' Future launched: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future' [05:57:07.506] | : . Using MultisessionFutureBackend ... done [05:57:07.506] | : run() for 'Future' () ... done [05:57:07.506] | future(..., label = NULL) ... done [05:57:07.507] | resolved() for MultisessionFuture () ... [05:57:07.508] | : Cluster node socket connection: index=4, id=397 [05:57:07.509] | : assertValidConnection() ... [05:57:07.509] | : . cluster node index: 1 [05:57:07.509] | : assertValidConnection() ... done [05:57:07.712] | : socketSelect(list(), timeout = 0.01, write = FALSE) returned FALSE; not resolved [05:57:07.713] | resolved() for MultisessionFuture () ... done [05:57:07.714] | resolve() for MultisessionFuture ... [05:57:07.714] | : resolved() for MultisessionFuture () ... [05:57:07.715] | : . Cluster node socket connection: index=4, id=397 [05:57:07.715] | : . assertValidConnection() ... [05:57:07.716] | : . ' cluster node index: 1 [05:57:07.716] | : . assertValidConnection() ... done [05:57:07.910] | : . receiveMessageFromWorker() for ClusterFuture ... [05:57:07.910] | : . ' cluster node index: 1 [05:57:07.911] | : . ' [1] TRUE [05:57:07.911] | : . ' received data: [05:57:07.911] | : . ' List of 5 [05:57:07.911] | : . ' $ type : chr "VALUE" [05:57:07.911] | : . ' $ value :List of 16 [05:57:07.911] | : . ' ..$ value : NULL [05:57:07.911] | : . ' ..$ visible : logi TRUE [05:57:07.911] | : . ' ..$ stdout : chr "" [05:57:07.911] | : . ' ..$ conditions :List of 1 [05:57:07.911] | : . ' .. ..$ :List of 5 [05:57:07.911] | : . ' .. .. ..$ condition:List of 2 [05:57:07.911] | : . ' .. .. .. ..$ message: chr "Woops" [05:57:07.911] | : . ' .. .. .. ..$ call : language eval(quote({ { ... [05:57:07.911] | : . ' .. .. .. ..- attr(*, "class")= chr [1:3] "simpleError" "error" "condition" [05:57:07.911] | : . ' .. .. ..$ calls :List of 10 [05:57:07.911] | : . ' .. .. .. ..$ : language eval(expr, envir = globalenv()) [05:57:07.911] | : . ' .. .. .. ..$ : language eval(expr, envir = globalenv()) [05:57:07.911] | : . ' .. .. .. ..$ : language local({ { ... [05:57:07.911] | : . ' .. .. .. ..$ : language eval.parent(substitute(eval(quote(expr), envir))) [05:57:07.911] | : . ' .. .. .. ..$ : language eval(expr, p) [05:57:07.911] | : . ' .. .. .. ..$ : language eval(expr, p) [05:57:07.911] | : . ' .. .. .. ..$ : language eval(quote({ { ... [05:57:07.911] | : . ' .. .. .. ..$ : language eval(quote({ { ... [05:57:07.911] | : . ' .. .. .. ..$ : language stop("Woops") [05:57:07.911] | : . ' .. .. .. ..$ : language eval(quote({ { ... [05:57:07.911] | : . ' .. .. ..$ session :List of 6 [05:57:07.911] | : . ' .. .. .. ..$ r :List of 15 [05:57:07.911] | : . ' .. .. .. .. ..$ platform : chr "x86_64-w64-mingw32" [05:57:07.911] | : . ' .. .. .. .. ..$ arch : chr "x86_64" [05:57:07.911] | : . ' .. .. .. .. ..$ os : chr "mingw32" [05:57:07.911] | : . ' .. .. .. .. ..$ crt : chr "ucrt" [05:57:07.911] | : . ' .. .. .. .. ..$ system : chr "x86_64, mingw32" [05:57:07.911] | : . ' .. .. .. .. ..$ status : chr "Under development (unstable)" [05:57:07.911] | : . ' .. .. .. .. ..$ major : chr "4" [05:57:07.911] | : . ' .. .. .. .. ..$ minor : chr "6.0" [05:57:07.911] | : . ' .. .. .. .. ..$ year : chr "2025" [05:57:07.911] | : . ' .. .. .. .. ..$ month : chr "06" [05:57:07.911] | : . ' .. .. .. .. ..$ day : chr "04" [05:57:07.911] | : . ' .. .. .. .. ..$ svn rev : chr "88278" [05:57:07.911] | : . ' .. .. .. .. ..$ language : chr "R" [05:57:07.911] | : . ' .. .. .. .. ..$ version.string: chr "R Under development (unstable) (2025-06-04 r88278 ucrt)" [05:57:07.911] | : . ' .. .. .. .. ..$ nickname : chr "Unsuffered Consequences" [05:57:07.911] | : . ' .. .. .. ..$ locale : chr "LC_COLLATE=C;LC_CTYPE=German_Germany.utf8;LC_MONETARY=C;LC_NUMERIC=C;LC_TIME=C" [05:57:07.911] | : . ' .. .. .. ..$ rngkind : chr [1:3] "Mersenne-Twister" "Inversion" "Rejection" [05:57:07.911] | : . ' .. .. .. ..$ namespaces: chr [1:16] "compiler" "parallelly" "graphics" "tools" ... [05:57:07.911] | : . ' .. .. .. ..$ search : chr [1:10] ".GlobalEnv" "package:future" "package:stats" "package:graphics" ... [05:57:07.911] | : . ' .. .. .. ..$ system : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:07.911] | : . ' .. .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:07.911] | : . ' .. .. ..$ timestamp: POSIXct[1:1], format: "2025-06-05 05:57:07" [05:57:07.911] | : . ' .. .. ..$ signaled : int 0 [05:57:07.911] | : . ' ..$ rng : logi FALSE [05:57:07.911] | : . ' ..$ seed : NULL [05:57:07.911] | : . ' ..$ misuseGlobalEnv : NULL [05:57:07.911] | : . ' ..$ misuseConnections :List of 3 [05:57:07.911] | : . ' .. ..$ added : NULL [05:57:07.911] | : . ' .. ..$ removed : NULL [05:57:07.911] | : . ' .. ..$ replaced: NULL [05:57:07.911] | : . ' ..$ misuseDevices : NULL [05:57:07.911] | : . ' ..$ misuseDefaultDevice: list() [05:57:07.911] | : . ' ..$ started : POSIXct[1:1], format: "2025-06-05 05:57:07" [05:57:07.911] | : . ' ..$ finished : POSIXct[1:1], format: "2025-06-05 05:57:07" [05:57:07.911] | : . ' ..$ uuid : chr [1:2] "4f3e63cf4070ed6ab86cc9b2ca6acb94" "11" [05:57:07.911] | : . ' ..$ session_uuid : chr "537c0abb4c1d55c6b6a213690c5f91d5" [05:57:07.911] | : . ' .. ..- attr(*, "source")=List of 5 [05:57:07.911] | : . ' .. .. ..$ host : Named chr "CRANWIN3" [05:57:07.911] | : . ' .. .. .. ..- attr(*, "names")= chr "COMPUTERNAME" [05:57:07.911] | : . ' .. .. ..$ info : Named chr [1:9] "Windows" "Server x64" "build 20348" "CRANWIN3" ... [05:57:07.911] | : . ' .. .. .. ..- attr(*, "names")= chr [1:9] "sysname" "release" "version" "nodename" ... [05:57:07.911] | : . ' .. .. ..$ pid : int 114280 [05:57:07.911] | : . ' .. .. ..$ time : POSIXct[1:1], format: "2025-06-05 05:57:07" [05:57:07.911] | : . ' .. .. ..$ random: int 2147483647 [05:57:07.911] | : . ' ..$ r_info :List of 4 [05:57:07.911] | : . ' .. ..$ version :Classes 'R_system_version', 'package_version', 'numeric_version' hidden list of 1 [05:57:07.911] | : . ' .. .. ..$ : int [1:3] 4 6 0 [05:57:07.911] | : . ' .. ..$ os : chr "windows" [05:57:07.911] | : . ' .. ..$ os_name : chr "Windows" [05:57:07.911] | : . ' .. ..$ captures_utf8: logi TRUE [05:57:07.911] | : . ' ..$ version : chr "1.8" [05:57:07.911] | : . ' ..- attr(*, "class")= chr "FutureResult" [05:57:07.911] | : . ' $ success: logi TRUE [05:57:07.911] | : . ' $ time : 'proc_time' Named num [1:5] 0.06 0.02 0.41 NA NA [05:57:07.911] | : . ' ..- attr(*, "names")= chr [1:5] "user.self" "sys.self" "elapsed" "user.child" ... [05:57:07.911] | : . ' $ tag : NULL [05:57:07.955] | : . ' Received FutureResult [05:57:07.955] | : . ' FutureResult: [05:57:07.955] | : . ' value: 'NULL' [05:57:07.955] | : . ' visible: TRUE [05:57:07.955] | : . ' stdout: character [05:57:07.955] | : . ' conditions: [n = 1] simpleError [05:57:07.955] | : . ' RNG used: FALSE [05:57:07.955] | : . ' duration: 0.4014468 secs (started 2025-06-05 05:57:07.506138) [05:57:07.955] | : . ' version: 1.8 [05:57:07.956] | : . ' FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'remove', earlySignal = 0) ... [05:57:07.957] | : . ' , Removed future from position #1 [05:57:07.957] | : . ' , Number of registered futures: 0 [05:57:07.958] | : . ' FutureRegistry('workers-0339a486da8ccfc6abc9c85ecf3ab757', action = 'remove', earlySignal = 0) ... done [05:57:07.958] | : . ' Erased future from future backend [05:57:07.958] | : . ' result() for ClusterFuture ... [05:57:07.959] | : . ' , result already collected: FutureResult [05:57:07.959] | : . ' result() for ClusterFuture ... done [05:57:07.959] | : . ' signalConditions() ... [05:57:07.959] | : . ' , include = 'immediateCondition' [05:57:07.960] | : . ' , exclude = [05:57:07.960] | : . ' , resignal = FALSE [05:57:07.960] | : . ' , Number of conditions: 1 [05:57:07.960] | : . ' , int 1 [05:57:07.965] | : . ' , Condition #1 (class: 'simpleError', 'error', 'condition'): [05:57:07.965] | : . ' signalConditions() ... done [05:57:07.966] | : . receiveMessageFromWorker() for ClusterFuture ... done [05:57:07.966] | : . receiveMessageFromWorker() returned object of class FutureResult; resolved [05:57:07.966] | : resolved() for MultisessionFuture () ... done [05:57:07.966] | : assertFutureResult() ... [05:57:07.967] | : . Future uuid: 4f3e63cf4070ed6ab86cc9b2ca6acb94[05:57:07.967] | : . Future uuid: 11 [05:57:07.967] | : . identical; success [05:57:07.967] | : assertFutureResult() ... done [05:57:07.967] | : A MultisessionFuture was resolved (result was not collected) [05:57:07.968] | resolve() for MultisessionFuture ... done MultisessionFuture: Label: Expression: { Sys.sleep(0.3) 42L stop("Woops") } Globals: Packages: L'Ecuyer-CMRG RNG seed: (seed = FALSE) Capture standard output: TRUE Capture condition classes: 'condition' (excluding '') Immediate condition classes: 'immediateCondition' Lazy evaluation: FALSE Local evaluation: TRUE Asynchronous evaluation: TRUE Early signaling: FALSE Environment: R_GlobalEnv State: 'finished' Resolved: TRUE Unique identifier: 4f3e63cf4070ed6ab86cc9b2ca6acb94-11 Owner process: 4f3e63cf4070ed6ab86cc9b2ca6acb94 Class: 'MultisessionFuture', 'ClusterFuture', 'MultiprocessFuture', 'Future' Value: 27 bytes of class 'NULL' Conditions captured: [n=1] 'simpleError' Duration: 0.4014468 secs (started 2025-06-05 05:57:07.506138) Worker process: 537c0abb4c1d55c6b6a213690c5f91d5 > message("*** backtrace( ) - exceptions ... DONE") *** backtrace( ) - exceptions ... DONE Sourcing 6 epilogue scripts ... 01/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/001.undo-future.R' 02/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/002.undo-state.R' Failed to undo environment variables: - Expected environment variables: [n=213] '!ExitCode', 'ALLUSERSPROFILE', 'APPDATA', 'BIBINPUTS', 'BINDIR', 'BSTINPUTS', 'COMMONPROGRAMFILES', 'COMPUTERNAME', 'COMSPEC', 'CURL_CA_BUNDLE', 'CYGWIN', 'CommonProgramFiles(x86)', 'CommonProgramW6432', 'DriverData', 'HOME', 'HOMEDRIVE', 'HOMEPATH', 'JAGS_ROOT', 'JAVA_HOME', 'LANGUAGE', 'LC_COLLATE', 'LC_MONETARY', 'LC_TIME', 'LOCALAPPDATA', 'LOGONSERVER', 'LS_HOME', 'LS_LICENSE_PATH', 'MAKE', 'MAKEFLAGS', 'MAKELEVEL', 'MFLAGS', 'MSMPI_BENCHMARKS', 'MSMPI_BIN', 'MSYS2_ENV_CONV_EXCL', 'NUMBER_OF_PROCESSORS', 'OCL', 'OMP_THREAD_LIMIT', 'OS', 'PATH', 'PATHEXT', 'PROCESSOR_ARCHITECTURE', 'PROCESSOR_IDENTIFIER', 'PROCESSOR_LEVEL', 'PROCESSOR_REVISION', 'PROGRAMFILES', 'PROMPT', 'PSModulePath', 'PUBLIC', 'PWD', 'ProgramData', 'ProgramFiles(x86)', 'ProgramW6432', 'RTOOLS44_HOME', 'RTOOLS45_HOME', 'R_ARCH', 'R_BROWSER', 'R_BZIPCMD', 'R_CMD', 'R_COMPILED_BY', 'R_CRAN_WEB', 'R_CUSTOM_TOOLS_PATH', 'R_CUSTOM_TOOLS_SOFT', 'R_DOC_DIR', 'R_ENVIRON_USER', 'R_GSCMD', 'R_GZIPCMD', 'R_HOME', 'R_INCLUDE_DIR', 'R_INSTALL_TAR', 'R_LIBS', 'R_LIBS_SITE', 'R_LIBS_USER', 'R_MAX_NUM_DLLS', 'R_OSTYPE', 'R_PAPERSIZE', 'R_PAPERSIZE_USER', 'R_PARALLELLY_MAKENODEPSOCK_AUTOKILL', 'R_PARALLELLY_MAKENODEPSOCK_CONNECTTIMEOUT', 'R_PARALLELLY_MAKENODEPSOCK_RSCRIPT_LABEL', 'R_PARALLELLY_MAKENODEPSOCK_SESSIONINFO_PKGS', 'R_PARALLELLY_MAKENODEPSOCK_TIMEOUT', 'R_PARALLELLY_RANDOM_PORTS', 'R_PARALLEL_PORT', 'R_RD4PDF', 'R_RTOOLS45_PATH', 'R_SCRIPT_LEGACY', 'R_SHARE_DIR', 'R_TESTME_NAME', 'R_TESTME_PACKAGE', 'R_TESTME_PATH', 'R_TESTS', 'R_UNZIPCMD', 'R_USER', 'R_VERSION', 'R_ZIPCMD', 'SED', 'SHLVL', 'SYSTEMDRIVE', 'SYSTEMROOT', 'TAR', 'TAR_OPTIONS', 'TEMP', 'TERM', 'TEXINPUTS', 'TMP', 'TMPDIR', 'USERDOMAIN', 'USERDOMAIN_ROAMINGPROFILE', 'USERNAME', 'USERPROFILE', 'WINDIR', '_', '_R_CHECK_AUTOCONF_', '_R_CHECK_BOGUS_RETURN_', '_R_CHECK_BROWSER_NONINTERACTIVE_', '_R_CHECK_BUILD_VIGNETTES_SEPARATELY_', '_R_CHECK_CODETOOLS_PROFILE_', '_R_CHECK_CODE_ASSIGN_TO_GLOBALENV_', '_R_CHECK_CODE_ATTACH_', '_R_CHECK_CODE_CLASS_IS_STRING_', '_R_CHECK_CODE_DATA_INTO_GLOBALENV_', '_R_CHECK_CODE_USAGE_VIA_NAMESPACES_', '_R_CHECK_CODE_USAGE_WITHOUT_LOADING_', '_R_CHECK_CODE_USAGE_WITH_ONLY_BASE_ATTACHED_', '_R_CHECK_CODOC_VARIABLES_IN_USAGES_', '_R_CHECK_COMPACT_DATA2_', '_R_CHECK_COMPILATION_FLAGS_', '_R_CHECK_CONNECTIONS_LEFT_OPEN_', '_R_CHECK_CRAN_INCOMING_', '_R_CHECK_CRAN_INCOMING_ASPELL_RECHECK_MAYBE_', '_R_CHECK_CRAN_INCOMING_ASPELL_RECHECK_START_', '_R_CHECK_CRAN_INCOMING_CHECK_FILE_URIS_', '_R_CHECK_CRAN_INCOMING_CHECK_URLS_IN_PARALLEL_', '_R_CHECK_CRAN_INCOMING_NOTE_GNU_MAKE_', '_R_CHECK_CRAN_INCOMING_REMOTE_', '_R_CHECK_CRAN_INCOMING_USE_ASPELL_', '_R_CHECK_DATALIST_', '_R_CHECK_DEPRECATED_DEFUNCT_', '_R_CHECK_DOC_SIZES2_', '_R_CHECK_DOT_FIRSTLIB_', '_R_CHECK_DOT_INTERNAL_', '_R_CHECK_EXAMPLE_TIMING_THRESHOLD_', '_R_CHECK_EXECUTABLES_', '_R_CHECK_EXECUTABLES_EXCLUSIONS_', '_R_CHECK_FF_CALLS_', '_R_CHECK_FF_DUP_', '_R_CHECK_FORCE_SUGGESTS_', '_R_CHECK_FUTURE_FILE_TIMESTAMPS_', '_R_CHECK_FUTURE_FILE_TIMESTAMPS_LEEWAY_', '_R_CHECK_HAVE_MYSQL_', '_R_CHECK_HAVE_ODBC_', '_R_CHECK_HAVE_PERL_', '_R_CHECK_HAVE_POSTGRES_', '_R_CHECK_INSTALL_DEPENDS_', '_R_CHECK_INTERNALS2_', '_R_CHECK_LENGTH_1_CONDITION_', '_R_CHECK_LICENSE_', '_R_CHECK_LIMIT_CORES_', '_R_CHECK_LOG_USE_INFO_', '_R_CHECK_MATRIX_DATA_', '_R_CHECK_MBCS_CONVERSION_FAILURE_', '_R_CHECK_NATIVE_ROUTINE_REGISTRATION_', '_R_CHECK_NEWS_IN_PLAIN_TEXT_', '_R_CHECK_NO_RECOMMENDED_', '_R_CHECK_NO_STOP_ON_TEST_ERROR_', '_R_CHECK_ORPHANED_', '_R_CHECK_OVERWRITE_REGISTERED_S3_METHODS_', '_R_CHECK_PACKAGES_USED_IGNORE_UNUSED_IMPORTS_', '_R_CHECK_PACKAGES_USED_IN_TESTS_USE_SUBDIRS_', '_R_CHECK_PACKAGE_DATASETS_SUPPRESS_NOTES_', '_R_CHECK_PACKAGE_NAME_', '_R_CHECK_PKG_SIZES_', '_R_CHECK_PKG_SIZES_THRESHOLD_', '_R_CHECK_PRAGMAS_', '_R_CHECK_RD_EXAMPLES_T_AND_F_', '_R_CHECK_RD_LINE_WIDTHS_', '_R_CHECK_RD_MATH_RENDERING_', '_R_CHECK_RD_NOTE_LOST_BRACES_', '_R_CHECK_RD_VALIDATE_RD2HTML_', '_R_CHECK_REPLACING_IMPORTS_', '_R_CHECK_R_DEPENDS_', '_R_CHECK_S3_METHODS_SHOW_POSSIBLE_ISSUES_', '_R_CHECK_SCREEN_DEVICE_', '_R_CHECK_SERIALIZATION_', '_R_CHECK_SHLIB_OPENMP_FLAGS_', '_R_CHECK_SRC_MINUS_W_IMPLICIT_', '_R_CHECK_SUBDIRS_NOCASE_', '_R_CHECK_SUGGESTS_ONLY_', '_R_CHECK_SYSTEM_CLOCK_', '_R_CHECK_TESTS_NLINES_', '_R_CHECK_TEST_TIMING_', '_R_CHECK_TIMINGS_', '_R_CHECK_TOPLEVEL_FILES_', '_R_CHECK_UNDOC_USE_ALL_NAMES_', '_R_CHECK_UNSAFE_CALLS_', '_R_CHECK_URLS_SHOW_301_STATUS_', '_R_CHECK_VC_DIRS_', '_R_CHECK_VIGNETTES_NLINES_', '_R_CHECK_VIGNETTES_SKIP_RUN_MAYBE_', '_R_CHECK_VIGNETTE_TIMING_', '_R_CHECK_VIGNETTE_TITLES_', '_R_CHECK_WINDOWS_DEVICE_', '_R_CHECK_XREFS_NOTE_MISSING_PACKAGE_ANCHORS_', '_R_CHECK_XREFS_USE_ALIASES_FROM_CRAN_', '_R_CLASS_MATRIX_ARRAY_', '_R_DEPRECATED_IS_R_', '_R_S3_METHOD_LOOKUP_BASEENV_AFTER_GLOBALENV_', '_R_SHLIB_BUILD_OBJECTS_SYMBOL_TABLES_', '_R_USE_STRICT_R_HEADERS_', '__R_CHECK_DOC_FILES_NOTE_IF_ALL_SPECIAL__', 'maj.version', 'nextArg--timingsnextArg--install', 'tempdirname' - Environment variables still there: [n=0] - Environment variables missing: [n=1] 'MAKEFLAGS' Differences environment variable by environment variable: 03/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/090.gc.R' 04/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/099.session_info.R' 05/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/995.detritus-connections.R' 06/06 epilogue script 'D:/RCompile/CRANincoming/R-devel/lib/future/testme/_epilogue/999.detritus-files.R' Skipping, because path appears not to be an 'R CMD check' folder: 'D:/temp/2025_06_05_05_55_16_20588' Sourcing 6 epilogue scripts ... done Test time: user.self=1s, sys.self=0.06s, elapsed=3s, user.child=NAs, sys.child=NAs Test 'backtrace' ... success > > proc.time() user system elapsed 1.67 0.15 3.15