Running ‘000.sessionDetails.R’ [0s/1s]
  Running ‘ClusterRegistry.R’ [1s/2s]
  Running ‘Future-class.R’ [1s/4s]
  Running ‘FutureError.R’ [1s/1s]
  Running ‘FutureGlobals.R’ [1s/1s]
  Running ‘FutureRegistry.R’ [1s/2s]
  Running ‘adhoc_native_to_utf8.R’ [1s/1s]
  Running ‘backtrace.R’ [1s/8s]
  Running ‘bquote.R’ [1s/2s]
  Running ‘cluster,worker-termination.R’ [1s/4s]
  Running ‘cluster-missing-future-pkg.R’ [1s/3s]
  Running ‘cluster.R’ [2s/17s]
  Running ‘constant.R’ [1s/1s]
  Running ‘demo.R’ [9s/15s]
  Running ‘dotdotdot.R’ [2s/6s]
  Running ‘early-signaling.R’ [1s/14s]
  Running ‘future,labels.R’ [2s/5s]
  Running ‘future,optsenvvars.R’ [1s/4s]
  Running ‘future.R’ [1s/1s]
  Running ‘futureAssign.R’ [2s/6s]
  Running ‘futureAssign_OP.R’ [3s/8s]
  Running ‘futureAssign_OP_with_environment.R’ [1s/1s]
  Running ‘futureAssign_OP_with_listenv.R’ [1s/1s]
  Running ‘futureCall.R’ [3s/10s]
  Running ‘futureOf.R’ [1s/1s]
  Running ‘futureOf_with_environment.R’ [1s/1s]
  Running ‘futureOf_with_listenv.R’ [1s/1s]
  Running ‘futureSessionInfo.R’ [1s/1s]
  Running ‘futures.R’ [9s/21s]
  Running ‘globals,NSE.R’ [2s/6s]
  Running ‘globals,S4methods.R’ [1s/5s]
  Running ‘globals,formulas.R’ [4s/10s]
  Running ‘globals,locals.R’ [2s/6s]
  Running ‘globals,manual.R’ [4s/12s]
  Running ‘globals,resolve.R’ [1s/4s]
  Running ‘globals,subassignment.R’ [3s/9s]
  Running ‘globals,toolarge.R’ [1s/3s]
  Running ‘globals,tricky.R’ [8s/20s]
  Running ‘globals,tricky_recursive.R’ [1s/5s]
  Running ‘globalsOf,tweaks.R’ [1s/1s]
  Running ‘immediateCondition.R’ [1s/5s]
  Running ‘invalid-owner.R’ [1s/4s]
  Running ‘mandelbrot.R’ [1s/1s]
  Running ‘mpi.R’ [0s/1s]
  Running ‘multicore,multithreading.R’ [1s/2s]
  Running ‘multicore,worker-termination.R’ [1s/1s]
  Running ‘multicore.R’ [2s/5s]
  Running ‘multisession.R’ [2s/9s]
  Running ‘nbrOfWorkers.R’ [2s/8s]
  Running ‘nested_futures,mc.cores.R’ [3s/17s]
  Running ‘nested_futures.R’ [4s/14s]
  Running ‘non-exportable,connections.R’ [1s/3s]
  Running ‘objectSize.R’ [1s/1s]
  Running ‘plan.R’ [1s/6s]
  Running ‘relaying,muffle.R’ [1s/1s]
  Running ‘relaying,split.R’ [1s/1s]
  Running ‘relaying.R’ [2s/9s]
  Running ‘requestCore.R’ [1s/3s]
  Running ‘requestNode.R’ [1s/8s]
  Running ‘reserved-keyword-functions.R’ [1s/2s]
  Running ‘resolve.R’ [9s/39s]
  Running ‘resolved-non-blocking-test.R’ [1s/18s]
  Running ‘rng.R’ [13s/29s]
  Running ‘rng_utils.R’ [1s/1s]
  Running ‘sequential.R’ [1s/1s]
  Running ‘sessionDetails.R’ [1s/1s]
  Running ‘startup.R’ [1s/6s]
  Running ‘stdout.R’ [3s/7s]
  Running ‘tweak.R’ [1s/3s]
  Running ‘utils.R’ [1s/1s]
  Running ‘uuid.R’ [1s/1s]
  Running ‘whichIndex.R’ [1s/1s]
Running the tests in ‘tests/ClusterRegistry.R’ failed.
Complete output:
  > source("incl/start.R")
  [21:26:50.715] plan(): Setting new future strategy stack:
  [21:26:50.716] List of future strategies:
  [21:26:50.716] 1. sequential:
  [21:26:50.716]    - args: function (..., envir = parent.frame())
  [21:26:50.716]    - tweaked: FALSE
  [21:26:50.716]    - call: future::plan("sequential")
  [21:26:50.791] plan(): nbrOfWorkers() = 1
  > 
  > message("*** ClusterRegistry() ... ")
  *** ClusterRegistry() ... 
  > 
  > allCores <- 1:availCores
  > 
  > ## Speed up CRAN checks: Skip on CRAN Windows 32-bit
  > if (isWin32) allCores <- NULL
  > 
  > for (cores in allCores) {
  +   message(sprintf("Testing with %d cores ...", cores))
  +   options(mc.cores = cores)
  + 
  +   message("Available cores: ", availableCores())
  + 
  +   ## In case sessions have been created in previous tests
  +   message("Stopping any running cluster ...")
  +   ClusterRegistry("stop")
  +   cluster <- ClusterRegistry("get")
  +   stopifnot(length(cluster) == 0)
  +   message("Stopping any running cluster ... DONE")
  + 
  +   message("Starting cluster ...")
  +   res <- tryCatch({
  +     cluster <- ClusterRegistry("set", workers = availableCores() - 1L)
  +     str(cluster)
  +     print(cluster)
  +   }, error = identity)
  +   if (cores == 1) stopifnot(inherits(res, "error"))
  +   message("Starting cluster ... DONE")
  + 
  +   message("Starting dual-worker cluster ...")
  +   cluster <- ClusterRegistry(action = "start", workers = 2L)
  +   str(cluster)
  +   print(cluster)
  +   stopifnot(length(cluster) == 2L)
  +   message("Starting duel-worker cluster ... DONE")
  +   
  +   message("Starting single-worker cluster ...")
  +   cluster <- ClusterRegistry(action = "start", workers = 1L)
  +   str(cluster)
  +   print(cluster)
  +   stopifnot(length(cluster) == 1L)
  +   message("Starting single-worker cluster ... DONE")
  + 
  +   cluster <- ClusterRegistry(action = "get")
  +   print(cluster)
  +   stopifnot(length(cluster) == 1L)
  + 
  +   message("Stopping single-worker cluster ...")
  +   cluster <- ClusterRegistry(action = "stop")
  +   print(cluster)
  +   stopifnot(length(cluster) == 0L)
  +   message("Stopping single-worker cluster ... DONE")
  + 
  +   message(sprintf("Testing with %d cores ... DONE", cores))
  + } ## for (cores ...)
  Testing with 1 cores ...
  Available cores: 1
  Stopping any running cluster ...
  Stopping any running cluster ... DONE
  Starting cluster ...
  Starting cluster ... DONE
  Starting dual-worker cluster ...
  [21:26:50.993] [local output] makeClusterPSOCK() ...
  [21:26:51.098] [local output] Workers: [n = 2] 'localhost', 'localhost'
  [21:26:51.128] [local output] Base port: 37697
  [21:26:51.129] [local output] Getting setup options for 2 cluster nodes ...
  [21:26:51.129] [local output]  - Node 1 of 2 ...
  [21:26:51.130] [local output] localMachine=TRUE => revtunnel=FALSE
  
  [21:26:51.147] Testing if worker's PID can be inferred: ''/home/hornik/tmp/R.check/r-devel-gcc/Work/build/bin/Rscript' -e 'try(suppressWarnings(cat(Sys.getpid(),file="/home/hornik/tmp/scratch/RtmpEdF0ZL/worker.rank=1.parallelly.parent=67368.107287d1d2b1a.pid")), silent = TRUE)' -e 'file.exists("/home/hornik/tmp/scratch/RtmpEdF0ZL/worker.rank=1.parallelly.parent=67368.107287d1d2b1a.pid")''
  [21:26:51.970] - Possible to infer worker's PID: TRUE
  [21:26:51.970] [local output] Rscript port: 37697
  
  [21:26:51.971] [local output]  - Node 2 of 2 ...
  [21:26:51.971] [local output] localMachine=TRUE => revtunnel=FALSE
  
  [21:26:51.973] [local output] Rscript port: 37697
  
  [21:26:51.973] [local output] Getting setup options for 2 cluster nodes ... done
  [21:26:51.973] [local output]  - Parallel setup requested for some PSOCK nodes
  [21:26:51.974] [local output] Setting up PSOCK nodes in parallel
  [21:26:51.975] List of 36
  [21:26:51.975]  $ worker          : chr "localhost"
  [21:26:51.975]   ..- attr(*, "localhost")= logi TRUE
  [21:26:51.975]  $ master          : chr "localhost"
  [21:26:51.975]  $ port            : int 37697
  [21:26:51.975]  $ connectTimeout  : num 120
  [21:26:51.975]  $ timeout         : num 120
  [21:26:51.975]  $ rscript         : chr "'/home/hornik/tmp/R.check/r-devel-gcc/Work/build/bin/Rscript'"
  [21:26:51.975]  $ homogeneous     : logi TRUE
  [21:26:51.975]  $ rscript_args    : chr "--default-packages=datasets,utils,grDevices,graphics,stats,methods -e '#label=ClusterRegistry.R:67368:gimli2:ho"| __truncated__
  [21:26:51.975]  $ rscript_envs    : NULL
  [21:26:51.975]  $ rscript_libs    : NULL
  [21:26:51.975]  $ rscript_startup : NULL
  [21:26:51.975]  $ rscript_sh      : chr "sh"
  [21:26:51.975]  $ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ...
  [21:26:51.975]  $ methods         : logi TRUE
  [21:26:51.975]  $ socketOptions   : chr "no-delay"
  [21:26:51.975]  $ useXDR          : logi FALSE
  [21:26:51.975]  $ outfile         : chr "/dev/null"
  [21:26:51.975]  $ renice          : int NA
  [21:26:51.975]  $ rshcmd          : NULL
  [21:26:51.975]  $ user            : chr(0) 
  [21:26:51.975]  $ revtunnel       : logi FALSE
  [21:26:51.975]  $ rshlogfile      : NULL
  [21:26:51.975]  $ rshopts         : chr(0) 
  [21:26:51.975]  $ rank            : int 1
  [21:26:51.975]  $ manual          : logi FALSE
  [21:26:51.975]  $ dryrun          : logi FALSE
  [21:26:51.975]  $ quiet           : logi FALSE
  [21:26:51.975]  $ setup_strategy  : chr "parallel"
  [21:26:51.975]  $ local_cmd       : chr "'/home/hornik/tmp/R.check/r-devel-gcc/Work/build/bin/Rscript' --default-packages=datasets,utils,grDevices,graph"| __truncated__
  [21:26:51.975]  $ pidfile         : chr "/home/hornik/tmp/scratch/RtmpEdF0ZL/worker.rank=1.parallelly.parent=67368.107287d1d2b1a.pid"
  [21:26:51.975]  $ rshcmd_label    : NULL
  [21:26:51.975]  $ rsh_call        : NULL
  [21:26:51.975]  $ cmd             : chr "'/home/hornik/tmp/R.check/r-devel-gcc/Work/build/bin/Rscript' --default-packages=datasets,utils,grDevices,graph"| __truncated__
  [21:26:51.975]  $ localMachine    : logi TRUE
  [21:26:51.975]  $ make_fcn        :function (worker = getOption2("parallelly.localhost.hostname", "localhost"), 
  [21:26:51.975]     master = NULL, port, connectTimeout = getOption2("parallelly.makeNodePSOCK.connectTimeout", 
  [21:26:51.975]         2 * 60), timeout = getOption2("parallelly.makeNodePSOCK.timeout", 
  [21:26:51.975]         30 * 24 * 60 * 60), rscript = NULL, homogeneous = NULL, rscript_args = NULL, 
  [21:26:51.975]     rscript_envs = NULL, rscript_libs = NULL, rscript_startup = NULL, rscript_sh = c("auto", 
  [21:26:51.975]         "cmd", "sh"), default_packages = c("datasets", "utils", "grDevices", 
  [21:26:51.975]         "graphics", "stats", if (methods) "methods"), methods = TRUE, socketOptions = getOption2("parallelly.makeNodePSOCK.socketOptions", 
  [21:26:51.975]         "no-delay"), useXDR = getOption2("parallelly.makeNodePSOCK.useXDR", 
  [21:26:51.975]         FALSE), outfile = "/dev/null", renice = NA_integer_, rshcmd = getOption2("parallelly.makeNodePSOCK.rshcmd", 
  [21:26:51.975]         NULL), user = NULL, revtunnel = NA, rshlogfile = NULL, rshopts = getOption2("parallelly.makeNodePSOCK.rshopts", 
  [21:26:51.975]         NULL), rank = 1L, manual = FALSE, dryrun = FALSE, quiet = FALSE, 
  [21:26:51.975]     setup_strategy = getOption2("parallelly.makeNodePSOCK.setup_strategy", 
  [21:26:51.975]         "parallel"), action = c("launch", "options"), verbose = FALSE)  
  [21:26:51.975]  $ arguments       :List of 28
  [21:26:51.975]   ..$ worker          : chr "localhost"
  [21:26:51.975]   ..$ master          : NULL
  [21:26:51.975]   ..$ port            : int 37697
  [21:26:51.975]   ..$ connectTimeout  : num 120
  [21:26:51.975]   ..$ timeout         : num 120
  [21:26:51.975]   ..$ rscript         : NULL
  [21:26:51.975]   ..$ homogeneous     : NULL
  [21:26:51.975]   ..$ rscript_args    : NULL
  [21:26:51.975]   ..$ rscript_envs    : NULL
  [21:26:51.975]   ..$ rscript_libs    : NULL
  [21:26:51.975]   ..$ rscript_startup : NULL
  [21:26:51.975]   ..$ rscript_sh      : chr [1:3] "auto" "cmd" "sh"
  [21:26:51.975]   ..$ default_packages: chr [1:6] "datasets" "utils" "grDevices" "graphics" ...
  [21:26:51.975]   ..$ methods         : logi TRUE
  [21:26:51.975]   ..$ socketOptions   : chr "no-delay"
  [21:26:51.975]   ..$ useXDR          : logi FALSE
  [21:26:51.975]   ..$ outfile         : chr "/dev/null"
  [21:26:51.975]   ..$ renice          : int NA
  [21:26:51.975]   ..$ rshcmd          : NULL
  [21:26:51.975]   ..$ user            : NULL
  [21:26:51.975]   ..$ revtunnel       : logi NA
  [21:26:51.975]   ..$ rshlogfile      : NULL
  [21:26:51.975]   ..$ rshopts         : NULL
  [21:26:51.975]   ..$ rank            : int 1
  [21:26:51.975]   ..$ manual          : logi FALSE
  [21:26:51.975]   ..$ dryrun          : logi FALSE
  [21:26:51.975]   ..$ quiet           : logi FALSE
  [21:26:51.975]   ..$ setup_strategy  : chr "parallel"
  [21:26:51.975]  - attr(*, "class")= chr [1:2] "makeNodePSOCKOptions" "makeNodeOptions"
  [21:26:52.067] [local output] System call to launch all workers:
  [21:26:52.067] [local output] '/home/hornik/tmp/R.check/r-devel-gcc/Work/build/bin/Rscript' --default-packages=datasets,utils,grDevices,graphics,stats,methods -e '#label=ClusterRegistry.R:67368:gimli2:hornik' -e 'try(suppressWarnings(cat(Sys.getpid(),file="/home/hornik/tmp/scratch/RtmpEdF0ZL/worker.rank=1.parallelly.parent=67368.107287d1d2b1a.pid")), silent = TRUE)' -e 'options(socketOptions = "no-delay")' -e 'workRSOCK <- tryCatch(parallel:::.workRSOCK, error=function(e) parallel:::.slaveRSOCK); workRSOCK()' MASTER=localhost PORT=37697 OUT=/dev/null TIMEOUT=120 XDR=FALSE SETUPTIMEOUT=120 SETUPSTRATEGY=parallel
  [21:26:52.068] [local output] Starting PSOCK main server
  Error in serverSocket(port = port) : 
    creation of server socket failed: port 37697 cannot be opened
  Calls: ClusterRegistry -> makeCluster -> makeClusterPSOCK -> serverSocket
  Execution halted