Access method for bru_log
objects.
Note: Up to version 2.8.0
, bru_log()
was a deprecated alias for
bru_log_message()
. When running on 2.8.0
or earlier, use bru_log_get()
to access the global log, and cat(fit$bru_iinla$log, sep = "\n")
to print a
stored estimation object log.
After version 2.8.0
, use bru_log()
to access the global log, and
bru_log(fit)
to access a stored estimation log.
Usage
bru_log(x = NULL, verbosity = NULL)
# S3 method for class 'character'
bru_log(x, verbosity = NULL)
# S3 method for class 'bru_log'
bru_log(x, verbosity = NULL)
# S3 method for class 'iinla'
bru_log(x, verbosity = NULL)
# S3 method for class 'bru'
bru_log(x, verbosity = NULL)
# S3 method for class 'bru_log'
format(x, ..., timestamp = TRUE, verbosity = FALSE)
# S3 method for class 'bru_log'
print(x, ..., timestamp = TRUE, verbosity = FALSE)
# S3 method for class 'bru_log'
as.character(x, ...)
# S3 method for class 'bru_log'
x[i]
# S3 method for class 'bru_log'
c(...)
# S3 method for class 'bru_log'
length(x)
Arguments
- x
An object that is, contains, or can be converted to, a
bru_log
object. IfNULL
, refers to the globalinlabru
log.- verbosity
integer value for limiting the highest verbosity level being returned.
- ...
further arguments passed to or from other methods.
- timestamp
If
TRUE
, include the timestamp of each message. DefaultTRUE
.- i
indices specifying elements to extract. If
character
, denotes the sequence between bookmarki
and the next bookmark (or the end of the log ifi
is the last bookmark)
Value
bru_log
A bru_log
object, containing a
character vector of log messages, and potentially a vector of bookmarks.
Methods (by generic)
format(bru_log)
: Format abru_log
object for printing. Ifverbosity
isTRUE
, include the verbosity level of each message.print(bru_log)
: Print abru_log
object withcat(x, sep = "\n")
. Ifverbosity
isTRUE
, include the verbosity level of each message.as.character(bru_log)
: Convertbru_log
object to a plaincharacter
vector[
: Extract a subset of abru_log
objectc(bru_log)
: Concatenate severalbru_log
orcharacter
objects into abru_log
object.length(bru_log)
: Obtain the number of log entries into abru_log
object.
Functions
bru_log()
: Extract stored log messages. If non-NULL
, theverbosity
argument determines the maximum verbosity level of the messages to extract.
See also
Other inlabru log methods:
bru_log_bookmark()
,
bru_log_message()
,
bru_log_new()
,
bru_log_offset()
,
bru_log_reset()
Examples
bru_log(verbosity = 2L)
#> 2025-07-10 16:06:59.405794: inlabru loaded
#> 2025-07-10 16:06:59.406288: Clear override options
#> 2025-07-10 16:07:10.304761: bru: Preprocessing
#> 2025-07-10 16:07:10.596807: iinla: Iteration 1 [max:1]
#> 2025-07-10 16:07:11.181982: bru: Preprocessing
#> 2025-07-10 16:07:11.362748: iinla: Iteration 1 [max:1]
#> 2025-07-10 16:07:11.81689: bru: Preprocessing
#> 2025-07-10 16:07:12.000737: iinla: Iteration 1 [max:10]
#> 2025-07-10 16:07:12.407905: iinla: Step rescaling: 27.6% (norm0 = 298.2, norm1 = 362.7, norm01 = 560)
#> 2025-07-10 16:07:12.464187: iinla: Iteration 2 [max:10]
#> 2025-07-10 16:07:13.1795: iinla: Step rescaling: 99.8% (norm0 = 361.5, norm1 = 16.15, norm01 = 362.6)
#> 2025-07-10 16:07:13.227022: iinla: Max deviation from previous: 74400% of SD, and line search is active
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:13.228891: iinla: Iteration 3 [max:10]
#> 2025-07-10 16:07:13.648306: iinla: Step rescaling: 102% (norm0 = 16.15, norm1 = 0.01358, norm01 = 16.15)
#> 2025-07-10 16:07:13.695633: iinla: Max deviation from previous: 748% of SD, and line search is active
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:13.697402: iinla: Iteration 4 [max:10]
#> 2025-07-10 16:07:14.164212: iinla: Max deviation from previous: 11.6% of SD, and line search is inactive
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:14.16617: iinla: Iteration 5 [max:10]
#> 2025-07-10 16:07:14.634381: iinla: Max deviation from previous: 0.214% of SD, and line search is inactive
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:14.635617: iinla: Convergence criterion met.
#> Running final INLA integration step with known theta mode.
#> 2025-07-10 16:07:14.637475: iinla: Iteration 6 [max:10]
#> 2025-07-10 16:07:15.977059: bru: Preprocessing
#> 2025-07-10 16:07:16.080893: iinla: Iteration 1 [max:1]
#> 2025-07-10 16:07:22.026894: bru: Preprocessing
#> 2025-07-10 16:07:22.202355: iinla: Iteration 1 [max:1]
format(bru_log())
#> [1] "2025-07-10 16:06:59.405794: inlabru loaded"
#> [2] "2025-07-10 16:06:59.406288: Clear override options"
#> [3] "2025-07-10 16:07:10.304761: bru: Preprocessing"
#> [4] "2025-07-10 16:07:10.314284: Evaluate component inputs for each observation model"
#> [5] "2025-07-10 16:07:10.315897: bru_input(bru_comp_list)"
#> [6] "2025-07-10 16:07:10.317273: bru_input.bru_comp(x)"
#> [7] "2025-07-10 16:07:10.318929: bru_input(bru_input) for (x)"
#> [8] "2025-07-10 16:07:10.327774: bru_input(bru_input) for (x.group)"
#> [9] "2025-07-10 16:07:10.33436: bru_input(bru_input) for (x.repl)"
#> [10] "2025-07-10 16:07:10.340758: bru_input.bru_comp(Intercept)"
#> [11] "2025-07-10 16:07:10.34208: bru_input(bru_input) for (Intercept)"
#> [12] "2025-07-10 16:07:10.348582: bru_input(bru_input) for (Intercept.group)"
#> [13] "2025-07-10 16:07:10.354667: bru_input(bru_input) for (Intercept.repl)"
#> [14] "2025-07-10 16:07:10.496954: iinla: Start"
#> [15] "2025-07-10 16:07:10.498289: iinla: Evaluate component linearisations"
#> [16] "2025-07-10 16:07:10.499613: Linearise components for each observation model"
#> [17] "2025-07-10 16:07:10.501101: Linearise component 'x'"
#> [18] "2025-07-10 16:07:10.516061: Linearise component 'Intercept'"
#> [19] "2025-07-10 16:07:10.528588: iinla: Evaluate component simplifications"
#> [20] "2025-07-10 16:07:10.529979: Simplify component mappers for each observation model"
#> [21] "2025-07-10 16:07:10.531461: Simplify component 'x'"
#> [22] "2025-07-10 16:07:10.54467: Simplify component 'Intercept'"
#> [23] "2025-07-10 16:07:10.557432: iinla: Evaluate predictor linearisation"
#> [24] "2025-07-10 16:07:10.57058: iinla: Construct inla stack"
#> [25] "2025-07-10 16:07:10.595392: iinla: Model initialisation completed"
#> [26] "2025-07-10 16:07:10.596807: iinla: Iteration 1 [max:1]"
#> [27] "2025-07-10 16:07:11.181982: bru: Preprocessing"
#> [28] "2025-07-10 16:07:11.185894: Evaluate component inputs for each observation model"
#> [29] "2025-07-10 16:07:11.187336: bru_input(bru_comp_list)"
#> [30] "2025-07-10 16:07:11.18869: bru_input.bru_comp(x)"
#> [31] "2025-07-10 16:07:11.190029: bru_input(bru_input) for (x)"
#> [32] "2025-07-10 16:07:11.198755: bru_input(bru_input) for (x.group)"
#> [33] "2025-07-10 16:07:11.206124: bru_input(bru_input) for (x.repl)"
#> [34] "2025-07-10 16:07:11.212475: bru_input.bru_comp(Intercept)"
#> [35] "2025-07-10 16:07:11.213833: bru_input(bru_input) for (Intercept)"
#> [36] "2025-07-10 16:07:11.219957: bru_input(bru_input) for (Intercept.group)"
#> [37] "2025-07-10 16:07:11.225664: bru_input(bru_input) for (Intercept.repl)"
#> [38] "2025-07-10 16:07:11.281864: iinla: Start"
#> [39] "2025-07-10 16:07:11.283146: iinla: Evaluate component linearisations"
#> [40] "2025-07-10 16:07:11.284491: Linearise components for each observation model"
#> [41] "2025-07-10 16:07:11.285921: Linearise component 'x'"
#> [42] "2025-07-10 16:07:11.299724: Linearise component 'Intercept'"
#> [43] "2025-07-10 16:07:11.311983: iinla: Evaluate component simplifications"
#> [44] "2025-07-10 16:07:11.313298: Simplify component mappers for each observation model"
#> [45] "2025-07-10 16:07:11.31471: Simplify component 'x'"
#> [46] "2025-07-10 16:07:11.327887: Simplify component 'Intercept'"
#> [47] "2025-07-10 16:07:11.340573: iinla: Evaluate predictor linearisation"
#> [48] "2025-07-10 16:07:11.34741: iinla: Construct inla stack"
#> [49] "2025-07-10 16:07:11.361402: iinla: Model initialisation completed"
#> [50] "2025-07-10 16:07:11.362748: iinla: Iteration 1 [max:1]"
#> [51] "2025-07-10 16:07:11.81689: bru: Preprocessing"
#> [52] "2025-07-10 16:07:11.820564: Evaluate component inputs for each observation model"
#> [53] "2025-07-10 16:07:11.821882: bru_input(bru_comp_list)"
#> [54] "2025-07-10 16:07:11.823173: bru_input.bru_comp(z)"
#> [55] "2025-07-10 16:07:11.824488: bru_input(bru_input) for (z)"
#> [56] "2025-07-10 16:07:11.832339: bru_input(bru_input) for (z.group)"
#> [57] "2025-07-10 16:07:11.838393: bru_input(bru_input) for (z.repl)"
#> [58] "2025-07-10 16:07:11.843874: bru_input.bru_comp(Intercept)"
#> [59] "2025-07-10 16:07:11.845172: bru_input(bru_input) for (Intercept)"
#> [60] "2025-07-10 16:07:11.85067: bru_input(bru_input) for (Intercept.group)"
#> [61] "2025-07-10 16:07:11.856096: bru_input(bru_input) for (Intercept.repl)"
#> [62] "2025-07-10 16:07:11.91213: iinla: Start"
#> [63] "2025-07-10 16:07:11.913471: iinla: Evaluate component linearisations"
#> [64] "2025-07-10 16:07:11.914712: Linearise components for each observation model"
#> [65] "2025-07-10 16:07:11.9161: Linearise component 'z'"
#> [66] "2025-07-10 16:07:11.928486: Linearise component 'Intercept'"
#> [67] "2025-07-10 16:07:11.940636: iinla: Evaluate component simplifications"
#> [68] "2025-07-10 16:07:11.941908: Simplify component mappers for each observation model"
#> [69] "2025-07-10 16:07:11.94326: Simplify component 'z'"
#> [70] "2025-07-10 16:07:11.962167: Simplify component 'Intercept'"
#> [71] "2025-07-10 16:07:11.974602: iinla: Evaluate predictor linearisation"
#> [72] "2025-07-10 16:07:11.977596: Linearise with respect to component 'z'"
#> [73] "2025-07-10 16:07:11.982497: Linearise with respect to component 'Intercept'"
#> [74] "2025-07-10 16:07:11.985774: iinla: Construct inla stack"
#> [75] "2025-07-10 16:07:11.999405: iinla: Model initialisation completed"
#> [76] "2025-07-10 16:07:12.000737: iinla: Iteration 1 [max:10]"
#> [77] "2025-07-10 16:07:12.398895: iinla: Step rescaling: 61.8%, Contract (norm0 = 3092, norm1 = 2833, norm01 = 560)"
#> [78] "2025-07-10 16:07:12.401609: iinla: Step rescaling: 38.2%, Contract (norm0 = 632.8, norm1 = 468.9, norm01 = 560)"
#> [79] "2025-07-10 16:07:12.405245: iinla: Step rescaling: 27.61%, Approx Optimisation (norm0 = 298.2, norm1 = 362.7, norm01 = 560)"
#> [80] "2025-07-10 16:07:12.406632: iinla: |lin1-lin0| = 560\n <eta-lin1,delta>/|delta| = -318.1\n |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 174.3"
#> [81] "2025-07-10 16:07:12.407905: iinla: Step rescaling: 27.6% (norm0 = 298.2, norm1 = 362.7, norm01 = 560)"
#> [82] "2025-07-10 16:07:12.409735: iinla: Evaluate component linearisations"
#> [83] "2025-07-10 16:07:12.410959: Linearise components for each observation model"
#> [84] "2025-07-10 16:07:12.412355: Linearise component 'z'"
#> [85] "2025-07-10 16:07:12.431674: Linearise component 'Intercept'"
#> [86] "2025-07-10 16:07:12.443964: iinla: Evaluate predictor linearisation"
#> [87] "2025-07-10 16:07:12.446651: Linearise with respect to component 'z'"
#> [88] "2025-07-10 16:07:12.450256: Linearise with respect to component 'Intercept'"
#> [89] "2025-07-10 16:07:12.464187: iinla: Iteration 2 [max:10]"
#> [90] "2025-07-10 16:07:13.171431: iinla: Step rescaling: 162%, Expand (norm0 = 586.7, norm1 = 226.9, norm01 = 362.6)"
#> [91] "2025-07-10 16:07:13.173898: iinla: Step rescaling: 100%, Overstep (norm0 = 362.3, norm1 = 16.18, norm01 = 362.6)"
#> [92] "2025-07-10 16:07:13.176899: iinla: Step rescaling: 99.77%, Approx Optimisation (norm0 = 361.5, norm1 = 16.15, norm01 = 362.6)"
#> [93] "2025-07-10 16:07:13.178238: iinla: |lin1-lin0| = 362.6\n <eta-lin1,delta>/|delta| = -1.44\n |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 16.09"
#> [94] "2025-07-10 16:07:13.1795: iinla: Step rescaling: 99.8% (norm0 = 361.5, norm1 = 16.15, norm01 = 362.6)"
#> [95] "2025-07-10 16:07:13.181195: iinla: Evaluate component linearisations"
#> [96] "2025-07-10 16:07:13.182476: Linearise components for each observation model"
#> [97] "2025-07-10 16:07:13.183795: Linearise component 'z'"
#> [98] "2025-07-10 16:07:13.195896: Linearise component 'Intercept'"
#> [99] "2025-07-10 16:07:13.207951: iinla: Evaluate predictor linearisation"
#> [100] "2025-07-10 16:07:13.210469: Linearise with respect to component 'z'"
#> [101] "2025-07-10 16:07:13.213981: Linearise with respect to component 'Intercept'"
#> [102] "2025-07-10 16:07:13.227022: iinla: Max deviation from previous: 74400% of SD, and line search is active\n [stop if: <10% and line search inactive]"
#> [103] "2025-07-10 16:07:13.228891: iinla: Iteration 3 [max:10]"
#> [104] "2025-07-10 16:07:13.633803: iinla: Step rescaling: 162%, Expand (norm0 = 25.48, norm1 = 9.329, norm01 = 16.15)"
#> [105] "2025-07-10 16:07:13.636521: iinla: Step rescaling: 100%, Overstep (norm0 = 15.9, norm1 = 0.2508, norm01 = 16.15)"
#> [106] "2025-07-10 16:07:13.639703: iinla: Step rescaling: 101.6%, Approx Optimisation (norm0 = 16.15, norm1 = 0.01358, norm01 = 16.15)"
#> [107] "2025-07-10 16:07:13.646986: iinla: |lin1-lin0| = 16.15\n <eta-lin1,delta>/|delta| = -5.412e-06\n |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 0.01358"
#> [108] "2025-07-10 16:07:13.648306: iinla: Step rescaling: 102% (norm0 = 16.15, norm1 = 0.01358, norm01 = 16.15)"
#> [109] "2025-07-10 16:07:13.650045: iinla: Evaluate component linearisations"
#> [110] "2025-07-10 16:07:13.651374: Linearise components for each observation model"
#> [111] "2025-07-10 16:07:13.652665: Linearise component 'z'"
#> [112] "2025-07-10 16:07:13.664987: Linearise component 'Intercept'"
#> [113] "2025-07-10 16:07:13.676793: iinla: Evaluate predictor linearisation"
#> [114] "2025-07-10 16:07:13.67924: Linearise with respect to component 'z'"
#> [115] "2025-07-10 16:07:13.682806: Linearise with respect to component 'Intercept'"
#> [116] "2025-07-10 16:07:13.695633: iinla: Max deviation from previous: 748% of SD, and line search is active\n [stop if: <10% and line search inactive]"
#> [117] "2025-07-10 16:07:13.697402: iinla: Iteration 4 [max:10]"
#> [118] "2025-07-10 16:07:14.100863: iinla: Step rescaling: 162%, Expand (norm0 = 0.02197, norm1 = 0.008393, norm01 = 0.01358)"
#> [119] "2025-07-10 16:07:14.103448: iinla: Step rescaling: 100%, Overstep (norm0 = 0.01358, norm1 = 5.334e-08, norm01 = 0.01358)"
#> [120] "2025-07-10 16:07:14.106664: iinla: Step rescaling: 100%, Approx Optimisation (norm0 = 0.01358, norm1 = 5.327e-08, norm01 = 0.01358)"
#> [121] "2025-07-10 16:07:14.107987: iinla: |lin1-lin0| = 0.01358\n <eta-lin1,delta>/|delta| = 5.962e-11\n |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 5.327e-08"
#> [122] "2025-07-10 16:07:14.109813: iinla: Evaluate component linearisations"
#> [123] "2025-07-10 16:07:14.111036: Linearise components for each observation model"
#> [124] "2025-07-10 16:07:14.112428: Linearise component 'z'"
#> [125] "2025-07-10 16:07:14.131204: Linearise component 'Intercept'"
#> [126] "2025-07-10 16:07:14.143697: iinla: Evaluate predictor linearisation"
#> [127] "2025-07-10 16:07:14.146384: Linearise with respect to component 'z'"
#> [128] "2025-07-10 16:07:14.150179: Linearise with respect to component 'Intercept'"
#> [129] "2025-07-10 16:07:14.164212: iinla: Max deviation from previous: 11.6% of SD, and line search is inactive\n [stop if: <10% and line search inactive]"
#> [130] "2025-07-10 16:07:14.16617: iinla: Iteration 5 [max:10]"
#> [131] "2025-07-10 16:07:14.571959: iinla: Step rescaling: 162%, Expand (norm0 = 4.305e-07, norm1 = 1.644e-07, norm01 = 2.661e-07)"
#> [132] "2025-07-10 16:07:14.574506: iinla: Step rescaling: 100%, Overstep (norm0 = 2.661e-07, norm1 = 6.59e-13, norm01 = 2.661e-07)"
#> [133] "2025-07-10 16:07:14.577595: iinla: Step rescaling: 100%, Approx Optimisation (norm0 = 2.661e-07, norm1 = 6.985e-13, norm01 = 2.661e-07)"
#> [134] "2025-07-10 16:07:14.578846: iinla: Optimisation did not improve on previous solution."
#> [135] "2025-07-10 16:07:14.580136: iinla: |lin1-lin0| = 2.661e-07\n <eta-lin1,delta>/|delta| = -1.067e-13\n |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 6.503e-13"
#> [136] "2025-07-10 16:07:14.582012: iinla: Evaluate component linearisations"
#> [137] "2025-07-10 16:07:14.583201: Linearise components for each observation model"
#> [138] "2025-07-10 16:07:14.584599: Linearise component 'z'"
#> [139] "2025-07-10 16:07:14.597069: Linearise component 'Intercept'"
#> [140] "2025-07-10 16:07:14.615104: iinla: Evaluate predictor linearisation"
#> [141] "2025-07-10 16:07:14.617757: Linearise with respect to component 'z'"
#> [142] "2025-07-10 16:07:14.62127: Linearise with respect to component 'Intercept'"
#> [143] "2025-07-10 16:07:14.634381: iinla: Max deviation from previous: 0.214% of SD, and line search is inactive\n [stop if: <10% and line search inactive]"
#> [144] "2025-07-10 16:07:14.635617: iinla: Convergence criterion met.\n Running final INLA integration step with known theta mode."
#> [145] "2025-07-10 16:07:14.637475: iinla: Iteration 6 [max:10]"
#> [146] "2025-07-10 16:07:15.977059: bru: Preprocessing"
#> [147] "2025-07-10 16:07:15.982664: Evaluate component inputs for each observation model"
#> [148] "2025-07-10 16:07:15.983911: bru_input(bru_comp_list)"
#> [149] "2025-07-10 16:07:15.985102: bru_input.bru_comp(field)"
#> [150] "2025-07-10 16:07:15.986276: bru_input(bru_input) for (field)"
#> [151] "2025-07-10 16:07:15.993361: bru_input(bru_input) for (field.group)"
#> [152] "2025-07-10 16:07:15.998997: bru_input(bru_input) for (field.repl)"
#> [153] "2025-07-10 16:07:16.030402: iinla: Start"
#> [154] "2025-07-10 16:07:16.031595: iinla: Evaluate component linearisations"
#> [155] "2025-07-10 16:07:16.032776: Linearise components for each observation model"
#> [156] "2025-07-10 16:07:16.03407: Linearise component 'field'"
#> [157] "2025-07-10 16:07:16.048307: iinla: Evaluate component simplifications"
#> [158] "2025-07-10 16:07:16.049598: Simplify component mappers for each observation model"
#> [159] "2025-07-10 16:07:16.050894: Simplify component 'field'"
#> [160] "2025-07-10 16:07:16.065093: iinla: Evaluate predictor linearisation"
#> [161] "2025-07-10 16:07:16.068456: iinla: Construct inla stack"
#> [162] "2025-07-10 16:07:16.079632: iinla: Model initialisation completed"
#> [163] "2025-07-10 16:07:16.080893: iinla: Iteration 1 [max:1]"
#> [164] "2025-07-10 16:07:18.597748: bru_input(bru_comp_list)"
#> [165] "2025-07-10 16:07:22.026894: bru: Preprocessing"
#> [166] "2025-07-10 16:07:22.035414: Evaluate component inputs for each observation model"
#> [167] "2025-07-10 16:07:22.036707: bru_input(bru_comp_list)"
#> [168] "2025-07-10 16:07:22.037955: bru_input.bru_comp(x)"
#> [169] "2025-07-10 16:07:22.039247: bru_input(bru_input) for (x)"
#> [170] "2025-07-10 16:07:22.047928: bru_input(bru_input) for (x.group)"
#> [171] "2025-07-10 16:07:22.054692: bru_input(bru_input) for (x.repl)"
#> [172] "2025-07-10 16:07:22.060616: bru_input(bru_comp_list)"
#> [173] "2025-07-10 16:07:22.061898: bru_input.bru_comp(x)"
#> [174] "2025-07-10 16:07:22.063121: bru_input(bru_input) for (x)"
#> [175] "2025-07-10 16:07:22.069756: bru_input(bru_input) for (x.group)"
#> [176] "2025-07-10 16:07:22.075769: bru_input(bru_input) for (x.repl)"
#> [177] "2025-07-10 16:07:22.109191: iinla: Start"
#> [178] "2025-07-10 16:07:22.110588: iinla: Evaluate component linearisations"
#> [179] "2025-07-10 16:07:22.111915: Linearise components for each observation model"
#> [180] "2025-07-10 16:07:22.113307: Linearise component 'x'"
#> [181] "2025-07-10 16:07:22.135758: Linearise component 'x'"
#> [182] "2025-07-10 16:07:22.148793: iinla: Evaluate component simplifications"
#> [183] "2025-07-10 16:07:22.150127: Simplify component mappers for each observation model"
#> [184] "2025-07-10 16:07:22.151509: Simplify component 'x'"
#> [185] "2025-07-10 16:07:22.164652: Simplify component 'x'"
#> [186] "2025-07-10 16:07:22.177713: iinla: Evaluate predictor linearisation"
#> [187] "2025-07-10 16:07:22.185118: iinla: Construct inla stack"
#> [188] "2025-07-10 16:07:22.201079: iinla: Model initialisation completed"
#> [189] "2025-07-10 16:07:22.202355: iinla: Iteration 1 [max:1]"
#> [190] "2025-07-10 16:07:23.426212: bru_input(bru_input) for (LABEL)"
bru_log(verbosity = 2L)
#> 2025-07-10 16:06:59.405794: inlabru loaded
#> 2025-07-10 16:06:59.406288: Clear override options
#> 2025-07-10 16:07:10.304761: bru: Preprocessing
#> 2025-07-10 16:07:10.596807: iinla: Iteration 1 [max:1]
#> 2025-07-10 16:07:11.181982: bru: Preprocessing
#> 2025-07-10 16:07:11.362748: iinla: Iteration 1 [max:1]
#> 2025-07-10 16:07:11.81689: bru: Preprocessing
#> 2025-07-10 16:07:12.000737: iinla: Iteration 1 [max:10]
#> 2025-07-10 16:07:12.407905: iinla: Step rescaling: 27.6% (norm0 = 298.2, norm1 = 362.7, norm01 = 560)
#> 2025-07-10 16:07:12.464187: iinla: Iteration 2 [max:10]
#> 2025-07-10 16:07:13.1795: iinla: Step rescaling: 99.8% (norm0 = 361.5, norm1 = 16.15, norm01 = 362.6)
#> 2025-07-10 16:07:13.227022: iinla: Max deviation from previous: 74400% of SD, and line search is active
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:13.228891: iinla: Iteration 3 [max:10]
#> 2025-07-10 16:07:13.648306: iinla: Step rescaling: 102% (norm0 = 16.15, norm1 = 0.01358, norm01 = 16.15)
#> 2025-07-10 16:07:13.695633: iinla: Max deviation from previous: 748% of SD, and line search is active
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:13.697402: iinla: Iteration 4 [max:10]
#> 2025-07-10 16:07:14.164212: iinla: Max deviation from previous: 11.6% of SD, and line search is inactive
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:14.16617: iinla: Iteration 5 [max:10]
#> 2025-07-10 16:07:14.634381: iinla: Max deviation from previous: 0.214% of SD, and line search is inactive
#> [stop if: <10% and line search inactive]
#> 2025-07-10 16:07:14.635617: iinla: Convergence criterion met.
#> Running final INLA integration step with known theta mode.
#> 2025-07-10 16:07:14.637475: iinla: Iteration 6 [max:10]
#> 2025-07-10 16:07:15.977059: bru: Preprocessing
#> 2025-07-10 16:07:16.080893: iinla: Iteration 1 [max:1]
#> 2025-07-10 16:07:22.026894: bru: Preprocessing
#> 2025-07-10 16:07:22.202355: iinla: Iteration 1 [max:1]
print(bru_log(), timestamp = TRUE, verbosity = TRUE)
#> 2025-07-10 16:06:59.405794: inlabru loaded (level 1)
#> 2025-07-10 16:06:59.406288: Clear override options (level 1)
#> 2025-07-10 16:07:10.304761: bru: Preprocessing (level 1)
#> 2025-07-10 16:07:10.314284: Evaluate component inputs for each observation model (level 3)
#> 2025-07-10 16:07:10.315897: bru_input(bru_comp_list) (level 4)
#> 2025-07-10 16:07:10.317273: bru_input.bru_comp(x) (level 4)
#> 2025-07-10 16:07:10.318929: bru_input(bru_input) for (x) (level 5)
#> 2025-07-10 16:07:10.327774: bru_input(bru_input) for (x.group) (level 5)
#> 2025-07-10 16:07:10.33436: bru_input(bru_input) for (x.repl) (level 5)
#> 2025-07-10 16:07:10.340758: bru_input.bru_comp(Intercept) (level 4)
#> 2025-07-10 16:07:10.34208: bru_input(bru_input) for (Intercept) (level 5)
#> 2025-07-10 16:07:10.348582: bru_input(bru_input) for (Intercept.group) (level 5)
#> 2025-07-10 16:07:10.354667: bru_input(bru_input) for (Intercept.repl) (level 5)
#> 2025-07-10 16:07:10.496954: iinla: Start (level 3)
#> 2025-07-10 16:07:10.498289: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:10.499613: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:10.501101: Linearise component 'x' (level 4)
#> 2025-07-10 16:07:10.516061: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:10.528588: iinla: Evaluate component simplifications (level 3)
#> 2025-07-10 16:07:10.529979: Simplify component mappers for each observation model (level 3)
#> 2025-07-10 16:07:10.531461: Simplify component 'x' (level 4)
#> 2025-07-10 16:07:10.54467: Simplify component 'Intercept' (level 4)
#> 2025-07-10 16:07:10.557432: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:10.57058: iinla: Construct inla stack (level 3)
#> 2025-07-10 16:07:10.595392: iinla: Model initialisation completed (level 3)
#> 2025-07-10 16:07:10.596807: iinla: Iteration 1 [max:1] (level 1)
#> 2025-07-10 16:07:11.181982: bru: Preprocessing (level 1)
#> 2025-07-10 16:07:11.185894: Evaluate component inputs for each observation model (level 3)
#> 2025-07-10 16:07:11.187336: bru_input(bru_comp_list) (level 4)
#> 2025-07-10 16:07:11.18869: bru_input.bru_comp(x) (level 4)
#> 2025-07-10 16:07:11.190029: bru_input(bru_input) for (x) (level 5)
#> 2025-07-10 16:07:11.198755: bru_input(bru_input) for (x.group) (level 5)
#> 2025-07-10 16:07:11.206124: bru_input(bru_input) for (x.repl) (level 5)
#> 2025-07-10 16:07:11.212475: bru_input.bru_comp(Intercept) (level 4)
#> 2025-07-10 16:07:11.213833: bru_input(bru_input) for (Intercept) (level 5)
#> 2025-07-10 16:07:11.219957: bru_input(bru_input) for (Intercept.group) (level 5)
#> 2025-07-10 16:07:11.225664: bru_input(bru_input) for (Intercept.repl) (level 5)
#> 2025-07-10 16:07:11.281864: iinla: Start (level 3)
#> 2025-07-10 16:07:11.283146: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:11.284491: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:11.285921: Linearise component 'x' (level 4)
#> 2025-07-10 16:07:11.299724: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:11.311983: iinla: Evaluate component simplifications (level 3)
#> 2025-07-10 16:07:11.313298: Simplify component mappers for each observation model (level 3)
#> 2025-07-10 16:07:11.31471: Simplify component 'x' (level 4)
#> 2025-07-10 16:07:11.327887: Simplify component 'Intercept' (level 4)
#> 2025-07-10 16:07:11.340573: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:11.34741: iinla: Construct inla stack (level 3)
#> 2025-07-10 16:07:11.361402: iinla: Model initialisation completed (level 3)
#> 2025-07-10 16:07:11.362748: iinla: Iteration 1 [max:1] (level 1)
#> 2025-07-10 16:07:11.81689: bru: Preprocessing (level 1)
#> 2025-07-10 16:07:11.820564: Evaluate component inputs for each observation model (level 3)
#> 2025-07-10 16:07:11.821882: bru_input(bru_comp_list) (level 4)
#> 2025-07-10 16:07:11.823173: bru_input.bru_comp(z) (level 4)
#> 2025-07-10 16:07:11.824488: bru_input(bru_input) for (z) (level 5)
#> 2025-07-10 16:07:11.832339: bru_input(bru_input) for (z.group) (level 5)
#> 2025-07-10 16:07:11.838393: bru_input(bru_input) for (z.repl) (level 5)
#> 2025-07-10 16:07:11.843874: bru_input.bru_comp(Intercept) (level 4)
#> 2025-07-10 16:07:11.845172: bru_input(bru_input) for (Intercept) (level 5)
#> 2025-07-10 16:07:11.85067: bru_input(bru_input) for (Intercept.group) (level 5)
#> 2025-07-10 16:07:11.856096: bru_input(bru_input) for (Intercept.repl) (level 5)
#> 2025-07-10 16:07:11.91213: iinla: Start (level 3)
#> 2025-07-10 16:07:11.913471: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:11.914712: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:11.9161: Linearise component 'z' (level 4)
#> 2025-07-10 16:07:11.928486: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:11.940636: iinla: Evaluate component simplifications (level 3)
#> 2025-07-10 16:07:11.941908: Simplify component mappers for each observation model (level 3)
#> 2025-07-10 16:07:11.94326: Simplify component 'z' (level 4)
#> 2025-07-10 16:07:11.962167: Simplify component 'Intercept' (level 4)
#> 2025-07-10 16:07:11.974602: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:11.977596: Linearise with respect to component 'z' (level 5)
#> 2025-07-10 16:07:11.982497: Linearise with respect to component 'Intercept' (level 5)
#> 2025-07-10 16:07:11.985774: iinla: Construct inla stack (level 3)
#> 2025-07-10 16:07:11.999405: iinla: Model initialisation completed (level 3)
#> 2025-07-10 16:07:12.000737: iinla: Iteration 1 [max:10] (level 1)
#> 2025-07-10 16:07:12.398895: iinla: Step rescaling: 61.8%, Contract (norm0 = 3092, norm1 = 2833, norm01 = 560) (level 3)
#> 2025-07-10 16:07:12.401609: iinla: Step rescaling: 38.2%, Contract (norm0 = 632.8, norm1 = 468.9, norm01 = 560) (level 3)
#> 2025-07-10 16:07:12.405245: iinla: Step rescaling: 27.61%, Approx Optimisation (norm0 = 298.2, norm1 = 362.7, norm01 = 560) (level 3)
#> 2025-07-10 16:07:12.406632: iinla: |lin1-lin0| = 560
#> <eta-lin1,delta>/|delta| = -318.1
#> |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 174.3 (level 4)
#> 2025-07-10 16:07:12.407905: iinla: Step rescaling: 27.6% (norm0 = 298.2, norm1 = 362.7, norm01 = 560) (level 2)
#> 2025-07-10 16:07:12.409735: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:12.410959: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:12.412355: Linearise component 'z' (level 4)
#> 2025-07-10 16:07:12.431674: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:12.443964: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:12.446651: Linearise with respect to component 'z' (level 5)
#> 2025-07-10 16:07:12.450256: Linearise with respect to component 'Intercept' (level 5)
#> 2025-07-10 16:07:12.464187: iinla: Iteration 2 [max:10] (level 1)
#> 2025-07-10 16:07:13.171431: iinla: Step rescaling: 162%, Expand (norm0 = 586.7, norm1 = 226.9, norm01 = 362.6) (level 3)
#> 2025-07-10 16:07:13.173898: iinla: Step rescaling: 100%, Overstep (norm0 = 362.3, norm1 = 16.18, norm01 = 362.6) (level 3)
#> 2025-07-10 16:07:13.176899: iinla: Step rescaling: 99.77%, Approx Optimisation (norm0 = 361.5, norm1 = 16.15, norm01 = 362.6) (level 3)
#> 2025-07-10 16:07:13.178238: iinla: |lin1-lin0| = 362.6
#> <eta-lin1,delta>/|delta| = -1.44
#> |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 16.09 (level 4)
#> 2025-07-10 16:07:13.1795: iinla: Step rescaling: 99.8% (norm0 = 361.5, norm1 = 16.15, norm01 = 362.6) (level 2)
#> 2025-07-10 16:07:13.181195: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:13.182476: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:13.183795: Linearise component 'z' (level 4)
#> 2025-07-10 16:07:13.195896: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:13.207951: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:13.210469: Linearise with respect to component 'z' (level 5)
#> 2025-07-10 16:07:13.213981: Linearise with respect to component 'Intercept' (level 5)
#> 2025-07-10 16:07:13.227022: iinla: Max deviation from previous: 74400% of SD, and line search is active
#> [stop if: <10% and line search inactive] (level 1)
#> 2025-07-10 16:07:13.228891: iinla: Iteration 3 [max:10] (level 1)
#> 2025-07-10 16:07:13.633803: iinla: Step rescaling: 162%, Expand (norm0 = 25.48, norm1 = 9.329, norm01 = 16.15) (level 3)
#> 2025-07-10 16:07:13.636521: iinla: Step rescaling: 100%, Overstep (norm0 = 15.9, norm1 = 0.2508, norm01 = 16.15) (level 3)
#> 2025-07-10 16:07:13.639703: iinla: Step rescaling: 101.6%, Approx Optimisation (norm0 = 16.15, norm1 = 0.01358, norm01 = 16.15) (level 3)
#> 2025-07-10 16:07:13.646986: iinla: |lin1-lin0| = 16.15
#> <eta-lin1,delta>/|delta| = -5.412e-06
#> |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 0.01358 (level 4)
#> 2025-07-10 16:07:13.648306: iinla: Step rescaling: 102% (norm0 = 16.15, norm1 = 0.01358, norm01 = 16.15) (level 2)
#> 2025-07-10 16:07:13.650045: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:13.651374: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:13.652665: Linearise component 'z' (level 4)
#> 2025-07-10 16:07:13.664987: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:13.676793: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:13.67924: Linearise with respect to component 'z' (level 5)
#> 2025-07-10 16:07:13.682806: Linearise with respect to component 'Intercept' (level 5)
#> 2025-07-10 16:07:13.695633: iinla: Max deviation from previous: 748% of SD, and line search is active
#> [stop if: <10% and line search inactive] (level 1)
#> 2025-07-10 16:07:13.697402: iinla: Iteration 4 [max:10] (level 1)
#> 2025-07-10 16:07:14.100863: iinla: Step rescaling: 162%, Expand (norm0 = 0.02197, norm1 = 0.008393, norm01 = 0.01358) (level 3)
#> 2025-07-10 16:07:14.103448: iinla: Step rescaling: 100%, Overstep (norm0 = 0.01358, norm1 = 5.334e-08, norm01 = 0.01358) (level 3)
#> 2025-07-10 16:07:14.106664: iinla: Step rescaling: 100%, Approx Optimisation (norm0 = 0.01358, norm1 = 5.327e-08, norm01 = 0.01358) (level 3)
#> 2025-07-10 16:07:14.107987: iinla: |lin1-lin0| = 0.01358
#> <eta-lin1,delta>/|delta| = 5.962e-11
#> |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 5.327e-08 (level 4)
#> 2025-07-10 16:07:14.109813: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:14.111036: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:14.112428: Linearise component 'z' (level 4)
#> 2025-07-10 16:07:14.131204: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:14.143697: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:14.146384: Linearise with respect to component 'z' (level 5)
#> 2025-07-10 16:07:14.150179: Linearise with respect to component 'Intercept' (level 5)
#> 2025-07-10 16:07:14.164212: iinla: Max deviation from previous: 11.6% of SD, and line search is inactive
#> [stop if: <10% and line search inactive] (level 1)
#> 2025-07-10 16:07:14.16617: iinla: Iteration 5 [max:10] (level 1)
#> 2025-07-10 16:07:14.571959: iinla: Step rescaling: 162%, Expand (norm0 = 4.305e-07, norm1 = 1.644e-07, norm01 = 2.661e-07) (level 3)
#> 2025-07-10 16:07:14.574506: iinla: Step rescaling: 100%, Overstep (norm0 = 2.661e-07, norm1 = 6.59e-13, norm01 = 2.661e-07) (level 3)
#> 2025-07-10 16:07:14.577595: iinla: Step rescaling: 100%, Approx Optimisation (norm0 = 2.661e-07, norm1 = 6.985e-13, norm01 = 2.661e-07) (level 3)
#> 2025-07-10 16:07:14.578846: iinla: Optimisation did not improve on previous solution. (level 3)
#> 2025-07-10 16:07:14.580136: iinla: |lin1-lin0| = 2.661e-07
#> <eta-lin1,delta>/|delta| = -1.067e-13
#> |eta-lin0 - delta <delta,eta-lin0>/<delta,delta>| = 6.503e-13 (level 4)
#> 2025-07-10 16:07:14.582012: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:14.583201: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:14.584599: Linearise component 'z' (level 4)
#> 2025-07-10 16:07:14.597069: Linearise component 'Intercept' (level 4)
#> 2025-07-10 16:07:14.615104: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:14.617757: Linearise with respect to component 'z' (level 5)
#> 2025-07-10 16:07:14.62127: Linearise with respect to component 'Intercept' (level 5)
#> 2025-07-10 16:07:14.634381: iinla: Max deviation from previous: 0.214% of SD, and line search is inactive
#> [stop if: <10% and line search inactive] (level 1)
#> 2025-07-10 16:07:14.635617: iinla: Convergence criterion met.
#> Running final INLA integration step with known theta mode. (level 1)
#> 2025-07-10 16:07:14.637475: iinla: Iteration 6 [max:10] (level 1)
#> 2025-07-10 16:07:15.977059: bru: Preprocessing (level 1)
#> 2025-07-10 16:07:15.982664: Evaluate component inputs for each observation model (level 3)
#> 2025-07-10 16:07:15.983911: bru_input(bru_comp_list) (level 4)
#> 2025-07-10 16:07:15.985102: bru_input.bru_comp(field) (level 4)
#> 2025-07-10 16:07:15.986276: bru_input(bru_input) for (field) (level 5)
#> 2025-07-10 16:07:15.993361: bru_input(bru_input) for (field.group) (level 5)
#> 2025-07-10 16:07:15.998997: bru_input(bru_input) for (field.repl) (level 5)
#> 2025-07-10 16:07:16.030402: iinla: Start (level 3)
#> 2025-07-10 16:07:16.031595: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:16.032776: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:16.03407: Linearise component 'field' (level 4)
#> 2025-07-10 16:07:16.048307: iinla: Evaluate component simplifications (level 3)
#> 2025-07-10 16:07:16.049598: Simplify component mappers for each observation model (level 3)
#> 2025-07-10 16:07:16.050894: Simplify component 'field' (level 4)
#> 2025-07-10 16:07:16.065093: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:16.068456: iinla: Construct inla stack (level 3)
#> 2025-07-10 16:07:16.079632: iinla: Model initialisation completed (level 3)
#> 2025-07-10 16:07:16.080893: iinla: Iteration 1 [max:1] (level 1)
#> 2025-07-10 16:07:18.597748: bru_input(bru_comp_list) (level 4)
#> 2025-07-10 16:07:22.026894: bru: Preprocessing (level 1)
#> 2025-07-10 16:07:22.035414: Evaluate component inputs for each observation model (level 3)
#> 2025-07-10 16:07:22.036707: bru_input(bru_comp_list) (level 4)
#> 2025-07-10 16:07:22.037955: bru_input.bru_comp(x) (level 4)
#> 2025-07-10 16:07:22.039247: bru_input(bru_input) for (x) (level 5)
#> 2025-07-10 16:07:22.047928: bru_input(bru_input) for (x.group) (level 5)
#> 2025-07-10 16:07:22.054692: bru_input(bru_input) for (x.repl) (level 5)
#> 2025-07-10 16:07:22.060616: bru_input(bru_comp_list) (level 4)
#> 2025-07-10 16:07:22.061898: bru_input.bru_comp(x) (level 4)
#> 2025-07-10 16:07:22.063121: bru_input(bru_input) for (x) (level 5)
#> 2025-07-10 16:07:22.069756: bru_input(bru_input) for (x.group) (level 5)
#> 2025-07-10 16:07:22.075769: bru_input(bru_input) for (x.repl) (level 5)
#> 2025-07-10 16:07:22.109191: iinla: Start (level 3)
#> 2025-07-10 16:07:22.110588: iinla: Evaluate component linearisations (level 3)
#> 2025-07-10 16:07:22.111915: Linearise components for each observation model (level 3)
#> 2025-07-10 16:07:22.113307: Linearise component 'x' (level 4)
#> 2025-07-10 16:07:22.135758: Linearise component 'x' (level 4)
#> 2025-07-10 16:07:22.148793: iinla: Evaluate component simplifications (level 3)
#> 2025-07-10 16:07:22.150127: Simplify component mappers for each observation model (level 3)
#> 2025-07-10 16:07:22.151509: Simplify component 'x' (level 4)
#> 2025-07-10 16:07:22.164652: Simplify component 'x' (level 4)
#> 2025-07-10 16:07:22.177713: iinla: Evaluate predictor linearisation (level 3)
#> 2025-07-10 16:07:22.185118: iinla: Construct inla stack (level 3)
#> 2025-07-10 16:07:22.201079: iinla: Model initialisation completed (level 3)
#> 2025-07-10 16:07:22.202355: iinla: Iteration 1 [max:1] (level 1)
#> 2025-07-10 16:07:23.426212: bru_input(bru_input) for (LABEL) (level 5)