runtime-logging.md 18.9 KB
Newer Older
larnu committed
1
Registro de anotaciones
larnu committed
2 3 4 5 6 7 8 9 10 11 12 13 14 15 16 17 18 19 20 21 22 23 24 25 26 27 28 29 30 31 32 33 34 35 36 37
=======================

Yii proporciona un poderoso framework dedicado al registro de anotaciones (logging) que es altamente personalizable y 
extensible. Usando este framework se pueden guardar fácilmente anotaciones (logs) de varios tipos de mensajes, 
filtrarlos, y unificarlos en diferentes destinos que pueden ser archivos, bases de datos o emails.


Usar el framework de registro de anotaciones de Yii involucra los siguientes pasos:

* Registrar [mensajes de las anotaciones](#log-messages) en distintos lugares del código;
* Configurar los [destinos de las anotaciones](#log-targets) en la configuración de la aplicación para filtrar y 
  exportar los mensajes de las anotaciones;
* Examinar los mensajes filtrados de los las anotaciones exportadas para diferentes destinos 
  (p. ej. [Yii debugger](tool-debugger.md)).

En esta sección, se describirán principalmente los dos primeros pasos.

## Anotación de Messages <a name="log-messages"></a>

Registrar mensajes de anotación es tan simple como llamar a uno de los siguientes métodos de registro de anotaciones.

* [[Yii::trace()]]: registra un mensaje para trazar el funcionamiento de una sección de código. Se usa principalmente 
  para tareas de desarrollo.
* [[Yii::info()]]: registra un mensaje que transmite información útil.
* [[Yii::warning()]]: registra un mensaje de advertencia que indica que ha sucedido algo inesperado.
* [[Yii::error()]]: registra un error fatal que debe ser investigado tan pronto como sea posible.

Estos métodos registran mensajes de varios *niveles de severidad* y *categorías*. Comparten el mismo registro de 
función `function ($message, $category = 'application')`, donde `$message` representa el mensaje del registro que 
tiene que ser registrado, mientras que `$category` es la categoría del registro de mensaje. El código del siguiente 
ejemplo registra la huella del mensaje para la categoría `application`:

```php
Yii::trace('start calculating average revenue');
```

larnu committed
38
> Información: Los mensajes de registro pueden ser tanto cadenas de texto como datos complejos, como arrays u objetos. 
larnu committed
39 40 41 42 43 44 45 46 47 48 49 50 51 52 53 54 55 56 57 58 59 60 61 62 63 64 65 66 67
  Es responsabilidad de los [destinos de registros](#log-targets) tratar los mensajes de registro de manera apropiada. 
  De forma predeterminada, si un mensaje de registro no es una cadena de texto, se exporta como si fuera un string 
  llamando a [[yii\helpers\VarDumper::export()]].

Para organizar mejor y filtrar los mensajes de registro, se recomienda especificar una categoría apropiada para cada 
mensaje de registro. Se puede elegir un sistema de nombres jerárquicos por categorías que facilite a los 
[destino de registros](#log-targets) el filtrado de mensajes basándose en categorías. Una manera simple pero 
efectiva de organizarlos es usar la constante predefinida (magic constant) de PHP `__METHOD__` como nombre de 
categoría. Además este es el enfoque que se usa en el código del núcleo (core) del framework Yii. Por ejemplo,

```php
Yii::trace('start calculating average revenue', __METHOD__);
```

La constante `__METHOD__` equivale al nombre del método (con el prefijo del nombre completo del nombre de clase) donde 
se encuentra la constante. Por ejemplo, es igual a la cadena `'app\controllers\RevenueController::calculate'` si la 
linea anterior de código se llamara dentro de este método.

> Información: Los métodos de registro de anotaciones descritos anteriormente en realidad son accesos directos al 
  método [[yii\log\Logger::log()|log()]] del [[yii\log\Logger|logger object]] que es un singleton accesible a través 
  de la expresión `Yii::getLogger()`. Cuando se hayan registrado suficientes mensajes o cuando la aplicación haya 
  finalizado, el objeto de registro llamará [[yii\log\Dispatcher|message dispatcher]] para enviar los mensajes de 
  registro registrados a los [destiinos de registros](#log-targets).

## Destino de Registros <a name="log-targets"></a>

Un destino de registro es una instancia de la clase [[yii\log\Target]] o de una clase hija. Este filtra los 
mensajes de registro por sus niveles de severidad y sus categorías y después los exporta a algún medio. Por ejemplo, 
un [[yii\log\DbTarget|database target]] exporta los mensajes de registro filtrados a una tabla de base de datos, 
larnu committed
68 69
mientras que un [[yii\log\EmailTarget|email target]] exporta los mensajes de registro a una dirección de correo 
electrónico específica.
larnu committed
70 71

Se pueden registrar múltiples destinos de registros en una aplicación configurándolos en la 
larnu committed
72
[aplicación de componente](structure-application-components.md) `log` dentro de la configuración de aplicación, como 
larnu committed
73 74 75 76 77 78 79 80 81 82 83 84 85 86 87 88 89 90 91 92 93 94 95 96 97 98 99 100 101 102 103 104 105 106 107 108 109 110 111 112 113 114 115 116 117 118 119 120 121 122 123 124
en el siguiente ejemplo:

```php
return [
    // el componente log tiene que cargarse durante el proceso de bootstrapping
    'bootstrap' => ['log'],

    'components' => [
        'log' => [
            'targets' => [
                [
                    'class' => 'yii\log\DbTarget',
                    'levels' => ['error', 'warning'],
                ],
                [
                    'class' => 'yii\log\EmailTarget',
                    'levels' => ['error'],
                    'categories' => ['yii\db\*'],
                    'message' => [
                       'from' => ['log@example.com'],
                       'to' => ['admin@example.com', 'developer@example.com'],
                       'subject' => 'Database errors at example.com',
                    ],
                ],
            ],
        ],
    ],
];
```

> Nota: El componente `log` debe cargarse durante el proceso de [bootstrapping](runtime-bootstrapping.md) para que 
pueda enviar los mensajes de registro a los destinos inmediatamente. Este es el motivo por el que se lista en el 
array `bootstrap` como se muestra más arriba.

En el anterior código, se registran dos destinos de registros en la propiedad [[yii\log\Dispatcher::targets]]

* el primer destino gestiona los errores y las advertencias y las guarda en una tabla de la base de datos;
* el segundo destino gestiona mensajes los mensajes de error de las categorías cuyos nombres empiecen por 
  `yii\db\` y los envía por email a las direcciones `admin@example.com` y `developer@example.com`.

Yii incluye los siguientes destinos. En la API de documentación se pueden referencias a estas clases e 
información de configuración y uso.

* [[yii\log\DbTarget]]: almacena los mensajes de registro en una tabla de la base de datos.
* [[yii\log\EmailTarget]]: envía los mensajes de registro a direcciones de correo preestablecidas.
* [[yii\log\FileTarget]]: guarda los menajes de registro en archivos.
* [[yii\log\SyslogTarget]]: guarda los mensajes de registro en el syslog llamando a la función PHP `syslog()`.

A continuación, se describirá las características más comunes de todos los destinos de registros.

### Filtrado de Mensajes <a name="message-filtering"></a>

larnu committed
125 126
Se pueden configurar las propiedades [[yii\log\Target::levels|levels]] y [[yii\log\Target::categories|categories]] 
para cada destino de registros, con estas se especifican los niveles de severidad y las categorías de mensajes que 
larnu committed
127 128 129 130 131 132 133 134 135
deberán procesar sus destinos.

La propiedad [[yii\log\Target::levels|levels]] es un array que consta de uno o varios de los siguientes valores:

* `error`: correspondiente a los mensajes registrados por [[Yii::error()]].
* `warning`: correspondiente a los mensajes registrados por [[Yii::warning()]].
* `info`: correspondiente a los mensajes registrados por [[Yii::info()]].
* `trace`: correspondiente a los mensajes registrados por [[Yii::trace()]].
* `profile`: correspondiente a los mensajes registrados por [[Yii::beginProfile()]] y [[Yii::endProfile()]], que se 
larnu committed
136
  explicará más detalladamente en la subsección [Perfiles](#performance-profiling). 
larnu committed
137 138 139 140 141 142 143 144 145 146 147 148 149 150 151 152

Si no se especifica la propiedad [[yii\log\Target::levels|levels]], significa que el destino procesará los 
mensajes de *cualquier* nivel de severidad.

La propiedad [[yii\log\Target::categories|categories]] es un array que consta de categorías de mensaje o patrones. El 
destino sólo procesará mensajes de las categorías que se puedan encontrar o si coinciden con algún patrón listado 
en el array. Un patrón de categoría es un nombre de categoría al que se le añade un asterisco `*` al final. Un nombre 
de categoría coincide con un patrón si empieza por el mismo prefijo que el patrón. Por ejemplo, 
`yii\db\Command::execute` y `yii\db\Command::query` que se usan como nombres de categoría para los mensajes 
registrados en la clase [[yii\db\Command]], coinciden con el patrón `yii\db\*`.

Si no se especifica la propiedad [[yii\log\Target::categories|categories]], significa que el destino procesará 
los mensajes de *todas* las categorías.

Además añadiendo las categorías en listas blancas (whitelisting) mediante la propiedad 
[[yii\log\Target::categories|categories]], también se pueden añadir ciertas categorías en listas negras (blacklist) 
larnu committed
153
configurando la propiedad [[yii\log\Target::except|except]]. Si se encuentra la categoría de un mensaje o coincide 
larnu committed
154 155 156 157 158 159 160 161 162 163 164 165 166 167 168 169 170 171 172 173 174 175 176 177 178 179 180 181 182 183 184 185 186 187 188 189 190 191 192 193 194 195 196 197 198 199 200 201 202 203 204 205 206 207 208 209 210 211 212 213
algún patrón con esta propiedad, NO será procesada por el destino.

La siguiente configuración de destinos especifica que el destino solo debe procesar los mensajes de error y 
de advertencia de las categorías que coincidan con alguno de los siguientes patrones `yii\db\*` o 
`yii\web\HttpException:*`, pero no con `yii\web\HttpException:404`.

```php
[
    'class' => 'yii\log\FileTarget',
    'levels' => ['error', 'warning'],
    'categories' => [
        'yii\db\*',
        'yii\web\HttpException:*',
    ],
    'except' => [
        'yii\web\HttpException:404',
    ],
]
```

> Información: Cuando se captura una excepción de tipo HTTP por el [gestor de errores](runtime-handling-errors.md), se 
  registrará un mensaje de error con el nombre de categoría con formato `yii\web\HttpException:ErrorCode`. Por 
  ejemplo, la excepción [[yii\web\NotFoundHttpException]] causará un mensaje de error del tipo 
  `yii\web\HttpException:404`.

### Formato de los Mensajes <a name="message-formatting"></a>

Los destinos exportan los mensajes de registro filtrados en cierto formato. Por ejemplo, is se instala un 
destino de registros de la calse [[yii\log\FileTarget]], encontraremos un registro similar en el archivo de 
registro `runtime/log/app.log`:

```
2014-10-04 18:10:15 [::1][][-][trace][yii\base\Module::getModule] Loading module: debug
```

De forma predeterminada los mensajes de registro se formatearan por [[yii\log\Target::formatMessage()]] como en el 
siguiente ejemplo:

```
Timestamp [IP address][User ID][Session ID][Severity Level][Category] Message Text
```

Se puede personalizar el formato configurando la propiedad [[yii\log\Target::prefix]] que es un PHP ejecutable y 
devuelve un prefijo de mensaje personalizado. Por ejemplo, el siguiente código configura un destino de registro 
anteponiendo a cada mensaje de registro el ID de usuario (se eliminan la dirección IP y el ID por razones de 
privacidad).

```php
[
    'class' => 'yii\log\FileTarget',
    'prefix' => function ($message) {
        $user = Yii::$app->has('user', true) ? Yii::$app->get('user') : null;
        $userID = $user ? $user->getId(false) : '-';
        return "[$userID]";
    }
]
```

Además de prefijos de mensaje, destinos de registros también añaden alguna información de contexto en cada lote 
de mensajes de registro. De forma predeterminada, se incluyen los valores de las siguientes variables globales de 
larnu committed
214
PHP: `$_GET`, `$_POST`, `$_FILES`, `$_COOKIE`, `$_SESSION` y `$_SERVER`. Se puede ajustar el comportamiento 
larnu committed
215 216 217 218 219 220 221 222 223 224 225 226 227 228 229 230 231 232 233 234 235 236 237 238 239 240 241 242 243 244 245 246 247 248 249 250 251 252 253
configurando la propiedad [[yii\log\Target::logVars]] con los nombres de las variables globales que se quieran incluir 
con el destino del registro. Por ejemplo, la siguiente configuración de destino de registros especifica que 
sólo se añadirá al mensaje de registro el valor de la variable `$_SERVER`.

```php
[
    'class' => 'yii\log\FileTarget',
    'logVars' => ['_SERVER'],
]
```

Se puede configurar `logVars` para que sea un array vacío para deshabilitar totalmente la inclusión de información de 
contexto. O si se desea implementar un método propio de proporcionar información de contexto se puede sobrescribir el 
método [[yii\log\Target::getContextMessage()]].

### Nivel de Seguimiento de Mensajes <a name="trace-level"></a>

Durante el desarrollo, a veces se quiere visualizar de donde proviene cada mensaje de registro. Se puede lograr 
configurando la propiedad [[yii\log\Dispatcher::traceLevel|traceLevel]] del componente `log` como en el siguiente 
ejemplo:

```php
return [
    'bootstrap' => ['log'],
    'components' => [
        'log' => [
            'traceLevel' => YII_DEBUG ? 3 : 0,
            'targets' => [...],
        ],
    ],
];
```

La configuración de aplicación anterior establece el [[yii\log\Dispatcher::traceLevel|traceLevel]] para que sea 3 si 
`YII_DEBUG` esta habilitado y 0 si esta deshabilitado. Esto significa que si `YII_DEBUG` esta habilitado, a cada 
mensaje de registro se le añadirán como mucho 3 niveles de la pila de llamadas del mensaje que se este registrando; y 
si `YII_DEBUG` está deshabilitado, no se incluirá información de la pila de llamadas.

> Información: Obtener información de la pila de llamadas no es trivial. Por lo tanto, sólo se debe usar esta 
larnu committed
254
  característica durante el desarrollo o cuando se depura la aplicación.
larnu committed
255 256 257 258 259 260 261 262 263 264 265 266 267 268 269 270 271 272 273 274 275 276 277 278 279 280 281 282 283 284 285 286 287 288 289 290 291 292 293 294 295 296 297 298 299 300 301 302 303 304 305 306 307 308 309 310 311 312 313 314 315 316 317 318 319 320 321 322 323 324 325 326 327 328 329 330 331 332 333 334 335 336 337 338 339 340 341 342 343 344 345 346 347 348 349 350 351 352 353 354 355

### Liberación (Flushing) y Exportación de Mensajes <a name="flushing-exporting"></a>

Como se ha comentado anteriormente, los mensajes de registro se mantienen en un array por el 
[[yii\log\Logger|logger object]]. Para limitar el consumo de memoria de este array, el componente encargado del 
registro de mensajes enviará los mensajes registrados a los [destinos de registros](#log-targets) cada vez que el 
array acumule un cierto número de mensajes de registro. Se puede personalizar el número configurando la propiedad 
[[yii\log\Dispatcher::flushInterval|flushInterval]] del componente `log`:

```php
return [
    'bootstrap' => ['log'],
    'components' => [
        'log' => [
            'flushInterval' => 100,   // el valor predeterminado es 1000
            'targets' => [...],
        ],
    ],
];
```

> Información: También se produce la liberación de mensajes cuando la aplicación finaliza, esto asegura que los 
  destinos de los registros reciban los mensajes de registro.

Cuando el [[yii\log\Logger|logger object]] libera los mensajes de registro enviándolos a los 
[destinos de registros](#log-targets), estos no se exportan inmediatamente. La exportación de mensajes solo se 
produce cuando un destino de registros acumula un cierto número de mensajes filtrados. Se puede personalizar este 
número configurando la propiedad [[yii\log\Target::exportInterval|exportInterval]] de un 
[destinos de registros](#log-targets) individual, como se muestra a continuación,

```php
[
    'class' => 'yii\log\FileTarget',
    'exportInterval' => 100,  // el valor predeterminado es 1000
]
```

Debido al nivel de configuración de la liberación y exportación de mensajes, de forma predeterminada cuando se llama a 
`Yii::trace()` o cualquier otro método de registro de mensajes, NO veremos el registro de mensaje inmediatamente en 
los destinos de registros. Esto podría ser un problema para algunas aplicaciones de consola de ejecución 
prolongada (long-running). Para hacer que los mensajes de registro aparezcan inmediatamente en los destinos de 
registro se deben establecer [[yii\log\Dispatcher::flushInterval|flushInterval]] y 
[[yii\log\Target::exportInterval|exportInterval]] para que tengan valor 1 como se muestra a continuación:

```php
return [
    'bootstrap' => ['log'],
    'components' => [
        'log' => [
            'flushInterval' => 1,
            'targets' => [
                [
                    'class' => 'yii\log\FileTarget',
                    'exportInterval' => 1,
                ],
            ],
        ],
    ],
];
```

> Nota: El uso frecuente de liberación y exportación puede degradar el rendimiento de la aplicación.

### Conmutación de Destinos de Registros <a name="toggling-log-targets"></a>

Se puede habilitar o deshabilitar un destino de registro configuración su propiedad 
[[yii\log\Target::enabled|enabled]]. Esto se puede llevar a cabo a mediante la configuración del destino de 
registros o con la siguiente declaración PHP de código:

```php
Yii::$app->log->targets['file']->enabled = false;
```

El código anterior requiere que se asocie un destino como `file`, como se muestra a continuación usando las 
claves de texto en el array `targets`:

```php
return [
    'bootstrap' => ['log'],
    'components' => [
        'log' => [
            'targets' => [
                'file' => [
                    'class' => 'yii\log\FileTarget',
                ],
                'db' => [
                    'class' => 'yii\log\DbTarget',
                ],
            ],
        ],
    ],
];
```

### Creación de Nuevos Destinos <a name="new-targets"></a>

La creación de nuevas clases de destinos de registro es muy simple. Se necesita implementar el método 
[[yii\log\Target::export()]] enviando el contenido del array [[yii\log\Target::messages]] al medio designado. Se puede 
llamar al método [[yii\log\Target::formatMessage()]] para formatear los mensajes. Se pueden encontrar más detalles de 
destinos de registros en las clases incluidas en la distribución de Yii.

larnu committed
356
## Perfilado de Rendimiento <a name="performance-profiling"></a>
larnu committed
357 358 359 360 361 362 363 364 365 366 367 368 369 370 371 372 373 374 375 376 377 378 379 380 381 382 383 384 385 386 387 388 389 390 391 392 393 394 395 396 397

El Perfilado de rendimiento es un tipo especial de registro de mensajes que se usa para medir el tiempo que tardan en 
ejecutarse ciertos bloques de código y encontrar donde están los cuellos de botella de rendimiento. Por ejemplo, la 
clase [[yii\db\Command]] utiliza el perfilado de rendimiento para encontrar conocer el tiempo que tarda cada consulta 
a la base de datos.

Para usar el perfilado de rendimiento, primero debemos identificar los bloques de código que tienen que ser 
perfilados, para poder enmarcar su contenido como en el siguiente ejemplo:

```php
\Yii::beginProfile('myBenchmark');

... Empieza el perfilado del bloque de código ...

\Yii::endProfile('myBenchmark');
```

Donde `myBenchmark` representa un token único para identificar el bloque de código. Después cuando se examine el 
resulte del perfilado, se podrá usar este token para encontrar el tiempo que ha necesitado el correspondiente bloque 
de código.

Es importante asegurarse de que los pares de `beginProfile` y `endProfile` estén bien anidados. Por ejemplo,

```php
\Yii::beginProfile('block1');

    // código que será perfilado

    \Yii::beginProfile('block2');
        // más código para perfilar
    \Yii::endProfile('block2');

\Yii::endProfile('block1');
```

Si nos dejamos el `\Yii::endProfile('block1')` o lo intercambiamos `\Yii::endProfile('block1')` con 
`\Yii::endProfile('block2')`, el perfilado de rendimiento no funcionará.

Se registra un mensaje de registro con el nivel de severidad `profile` para cada bloque de código que se haya 
perfilado. Se puede configurar el [destino del registro](#log-targets) para reunir todos los mensajes y exportarlos. 
El [depurador de Yii](tool-debugger.md) incluye un panel de perfilado de rendimiento que muestra los resultados de 
larnu committed
398
perfilado.