From 9f64dc050d51960de349f4f76622d308912a9daa Mon Sep 17 00:00:00 2001 From: Jared Smith Date: Tue, 27 Feb 2018 04:53:48 -0500 Subject: [PATCH] Add logging section --- _distro_map.yml | 2 +- _topic_map.yml | 2 + en-US/anaconda/anaconda.adoc | 4 +- en-US/anaconda/anaconda_logging.adoc | 224 +++++++++++++++++++++++++++ 4 files changed, 229 insertions(+), 3 deletions(-) create mode 100644 en-US/anaconda/anaconda_logging.adoc diff --git a/_distro_map.yml b/_distro_map.yml index 56daac0..5d3b69c 100644 --- a/_distro_map.yml +++ b/_distro_map.yml @@ -6,6 +6,6 @@ fedora: site_name: Home site_url: https://docs.fedoraproject.org/ branches: - master: + anaconda: name: quick-docs dir: quick-docs diff --git a/_topic_map.yml b/_topic_map.yml index 1dedfa7..1ddf581 100644 --- a/_topic_map.yml +++ b/_topic_map.yml @@ -59,6 +59,8 @@ Topics: File: anaconda_distros - Name: Anaconda Updates File: anaconda_updates + - Name: Anaconda Logging + File: anaconda_logging - Name: (FIX ME!) AutoUpdates File: autoupdates - Name: (FIX ME!) Building a custom kernel diff --git a/en-US/anaconda/anaconda.adoc b/en-US/anaconda/anaconda.adoc index bbd96c9..f76ff3a 100644 --- a/en-US/anaconda/anaconda.adoc +++ b/en-US/anaconda/anaconda.adoc @@ -20,7 +20,7 @@ Anaconda provides advanced debugging features such as remote logging, access to [id="users"] == Users -If you are a user having problems with Anaconda, please use the user support forum for your distribution such as http://forums.fedoraforum.org/forumdisplay.php?f=6[Fedora Forum] or https://lists.fedoraproject.org/admin/lists/users.lists.fedoraproject.org/[fedora-users]. +If you are a user having problems with Anaconda, please use the user support forum for your distribution such as http://forums.fedoraforum.org/forumdisplay.php?f=6[Fedora Forum] or https://lists.fedoraproject.org/admin/lists/users.lists.fedoraproject.org/[the fedora-users mailing list]. From time to time, we may distribute updates for Anaconda to fix problems in Fedora releases. The link:anaconda_updates.html[updates] page explains how to use these updates images. @@ -31,7 +31,7 @@ See our link:Anaconda/Changes[migration guide] which summarizes changes for user [id="advanced-users"] == Advanced Users -If you are an advanced user of Anaconda, you should check out https://anaconda-installer.readthedocs.io/en/latest/boot-options.html[our reference to Anaconda command line options],https://anaconda-installer.readthedocs.io/en/latest/kickstart.html[our kickstart file format documentation] and link:Anaconda/Logging[ our reference to logging capabilities of Anaconda]. +If you are an advanced user of Anaconda, you should check out https://anaconda-installer.readthedocs.io/en/latest/boot-options.html[our reference to Anaconda command line options], https://anaconda-installer.readthedocs.io/en/latest/kickstart.html[our kickstart file format documentation] and link:anaconda_logging.html[our reference to logging capabilities of Anaconda]. There is a mailing list devoted to the use of kickstart. You can find the list signup and archive information at http://www.redhat.com/mailman/listinfo/kickstart-list[kickstart list]. diff --git a/en-US/anaconda/anaconda_logging.adoc b/en-US/anaconda/anaconda_logging.adoc new file mode 100644 index 0000000..1b014e7 --- /dev/null +++ b/en-US/anaconda/anaconda_logging.adoc @@ -0,0 +1,224 @@ += Anaconda Logging + +== Introduction +Anaconda tracks all of its activities in logs. +This includes: + +* changing installation steps (that roughly correspond to different screens in the graphical installer) +* storage devices detection and manipulation +* installation media detection +* network initialization +* kernel messages +* calls to critical methods within anaconda +* calls to external programs + +== Logging on the installed system +During the installation the logs are stored in the `/tmp` directory: + +* `/tmp/anaconda.log`, the general installation information, particularly the step changes. +* `/tmp/storage.log`, storage devices scan and manipulation (hard drives, partitions, LVM, RAID), partitioning +* `/tmp/program.log`, calls to external programs, their output +* `/tmp/syslog`, messages from kernel and external programs (Network Manager) +* `/tmp/yum.log`, yum's internal log +* `/tmp/dnf.log`, link:http://www.fedoraproject.org/wiki/Dnf[DNF]'s internal log +* `/tmp/dnf.hawkey.log`, link:http://www.fedoraproject.org/wiki/Dnf[DNF]'s Hawkey internal log +* `/tmp/dnf.rpm.log`, link:http://www.fedoraproject.org/wiki/Dnf[DNF]'s RPM internal log + +Certain log messages are also written to the terminals: + +* `/dev/tty3`, messages from `anaconda.log`, `storage.log` and `yum.log`. +* `/dev/tty4`, same as `syslog` +* `/dev/tty5`, stdout and stderr from external programs + +`tty3` and `tty4` reflect certain log files. +Log files always contain messages from all the loglevels, including debug, but the minimal loglevel on the terminals can be controlled with the `loglevel` link:https://anaconda-installer.readthedocs.io/en/latest/boot-options.html#inst-loglevel[command line option]. + +There are two other log files created on the target filesystem, in the `/root` directory, also accessible at `/mnt/sysimage/root` during the installation: +* `/mnt/sysimage/root/install.log`, log of the package installation process. +* `/mnt/sysimage/root/install.log.syslog`, messages from installation chroot logged through the system's syslog. + +Mostly information about users and groups created during dnf|yum's package installation. + +=== Log format +In files the format of the log messages is as follows: + +---- + H:M:S,ms LOGLEVEL facility:message +---- + +where: + +* `H:M:S` is the message timestamp +* `ms` is the millisecond part of timestamp. +Note that this will usually become zero on a remote syslog. +* `LOGLEVEL` is the message loglevel. +In theory, because kernel messages are part of anaconda logs, all loglevels that are defined in rsyslog can appear in the logfiles. +Anaconda itself will however log only at the following loglevels: +** `DEBUG` +** `INFO` +** `WARN` +** `ERR` +** `CRIT` +* `facility` is the program or component that created the message. +Could be for instance `kernel`, `anaconda`, `storage` or similar. +* `message` is the log message itself. + +For the logs running in terminals, the format simply is: + +---- + LOGLEVEL facility:message +---- + +== Remote logging via TCP +Anaconda supports remote logging handled through the rsyslog daemon running on the installed system. +It can be configured to forward its logs through TCP to an arbitrary machine in network that is also running a syslog daemon. +This is controlled with the `syslog` link:https://anaconda-installer.readthedocs.io/en/latest/boot-options.html#inst-syslog[command line option]. + +[WARNING] +===== +Do not forget to enable the port you are running your local syslog daemon on in your firewall. +===== + +=== What is logged remotely +Everything that is logged directly by anaconda should also appear in the remote logs. +This includes messages emitted by the loader and the storage subsystem. +All anaconda tracebacks (/tmp/anaconda-tb-xyz) are concatenated into a single file /tmp/anaconda-tb-all.log and then transferred. +Also, /tmp/x.log is transferred. + +The remote logging only works when the installer initializes network. +Once network is up, it takes a couple of minutes for rsyslogd to realize this. +Rsyslog has a queue for messages that couldn't be forwarded because of inaccessible network and it eventually forwards all of them, in the correct order. + +=== Configuration + +It's up to you how the remote logging daemon is configured, you can for instance log all incoming messages into one file or sort them into directories according to the IP address of the remote system. + +The anaconda RPM provides the `analog` script, which generates a suitable rsyslogd configuration file based on a couple of install parameters. +It is also able to generate a bash command to launch rsyslogd with the generated configuration. +Thus you can do from a shell: + $ eval `scripts/analog -p 6080 -s -o ./someconf /home/akozumpl/remote_inst` +This starts an rsyslog daemon that will listen on port 6080. +The logs from the remote machine with IP 10.34.33.221 will be stored under `/home/akozumpl/remote_inst/10.34.33.221/`, e.g. `/home/akozumpl/remote_inst/10.34.33.221/anaconda.log`. + +The remote syslog configuration exploits several log message characteristics to be able to sort them into the correct files: +* the IP of the message sender to know which machine generated the message and thud what directory does the message belong to. +* `anaconda.log, storage.log` and `program.log` have the name embedded in them as `programname`. +* `syslog` messages are coming in from kernel and daemon facilities, just like they do on the installed system +* `install.log.syslog` made during package installation is logged as a special `sysimage` hostname. + +Run `analog` without the `-o` option to see how exactly does a fitting configuration file look like. +Also notice that it uses the same message format for remote logging as anaconda does, but you can of course modify this to specify any format you want. + +=== See also +* [http://www.rsyslog.com/doc Rsyslog documentation] +* `man tailf` + +== Remote logging via virtio +QEMU/KVM in Fedora 13 and onwards allows one to create virtual machines with [[Features/VirtioSerial|multiple virtio char devices]] exposed to the guest machine. +One such device can be used to forward anaconda logs to the host machine. +In that way we can get logs forwarded in real time, as soon the anaconda logging subsystem is initialized (early) and not need to wait for the network to come up. +Also, it's the only way to forward the logs in a no-network setup. + +=== Configuration +Anaconda will be forwarding logs over virtio automatically if it is able to find the port `/dev/virtio-ports/org.fedoraproject.anaconda.log.0"`. +This is port is created using a libvirt XML directive that wires it to a TCP socket on the host's side. +It's then possible to read the logs from there directly, or make an rsyslog instance to parse them and file them into respective files. +See the ascii chart below for the whole ensemble: + + +---- + Anaconda--->rsyslog(guest)--->virtio(guest char device)--->kvm hypervisor--->virtio(TCP socket) + | + v + forwarded log files<---rsyslog(host) + +---- + +Step by step instructions to set everything up follow: + +. Create a testing virtual machine, e.g. using Virtual Manager +. Add the virtio-serial port to your virtual machine, direct it to the TCP port 6080 on the host. +Start by editing the guest configuration:`virsh edit ` +. In the guest editor, add following information into the `` section: +---- + + + + +---- +. Start the listening rsyslogd process on the host, using the `analog` script described [[#Remote_logging_via_TCP|above]]: +---- +eval `analog -p 6080 -o rsyslogd.conf -s /home/akozumpl/remote_inst` +---- +. Start the virtual machine. +. Continue with the installation. +Immediately after the Anaconda greeting is displayed the log messages will appear in the directory given to `analog` script, in the `127.0.0.1` subdirectory. + +==== virt-install + +If you are using virt-install you can configure it with the --channel option: + +---- +--channel tcp,host=127.0.0.1:6080,mode=connect,target_type=virtio,name=org.fedoraproject.anaconda.log.0 +---- + +=== Known issues and troubleshooting +* works in libvirt>=0.8.2 +* chroot syslog messages from `/mnt/sysimage/root/install.log.syslog` are not forwarded. +* it is not possible to start the machine unless something is listening on the TCP port where virtio-serial is connected. +* if you want to test that the virtio connection is working, instead of using analog and rsyslog just let a netcat utility listen on the given port, e.g. +`nc -l 0.0.0.0 6080`. +You should start seeing raw logs in the terminal once the guest machine starts booting. +* if both remote TCP logging via `syslog=` and remote virtio logging via `virtiolog=` are specified on the command line, one has to setup two rsyslogd instances on the server/host to listen to both the connections otherwise the sending rsyslog's queues get full and the forwarding stops. + +=== See also +* link:http://fedoraproject.org/wiki/Features/VirtioSerial[VirtioSerial] +* [http://wiki.libvirt.org/page/Virtio Virtio at the libvirt wiki] +* link:http://libvirt.org/formatdomain.html#elementsConsole[libvirt domain XML format] + +== Anaconda logs on the running system +After every successful installation, anaconda logs are copied into `/var/log` on the system you just installed. +To avoid name clashes with other log files there, the anaconda logs are renamed: + +{| +! Name during installation !! Name on the target system +|- +| `/tmp/anaconda.log` || `/var/log/anaconda.log` +|- +| `/tmp/syslog` || `/var/log/anaconda.syslog` +|- +| `/tmp/X.log` || `/var/log/anaconda.xlog` +|- +| `/tmp/program.log` || `/var/log/anaconda.program.log` +|- +| `/tmp/storage.log` || `/var/log/anaconda.storage.log` +|- +| `/tmp/yum.log` || `/var/log/anaconda.yum.log` +|- +| `/tmp/ifcfg.log` (new in F14) || not copied +|} + +Starting with Fedora 15 (or post F14 Rawhide), the logs go to `/var/log/anaconda` directory on the target system, including ifcfg.log inroduced in F14. + +== Logging tips + +If you are asked to provide logs for a bugzilla, your best option is switching from the anaconda GUI to tty2 and then use scp to copy the files to your computer, e.g.: + cd /tmp + scp anaconda.log aklap:/home/akozumpl/ + +It is also possible to make a complete dump of a state of running anaconda process (the same dump that is compiled automatically if an unhandled exception occurs). +To do this send the main anaconda process SIGUSR2: + kill -USR2 `cat /var/run/anaconda.pid`` + +This builds a file `/tmp/anaconda-tb-?????` that also contains `anaconda.log`, `storage.log` and `syslog`. + +If you are on a KVM virtual machine and there's no scp available (stage1), you can (after setting up the network if not up already) redirect to a special tcp file, on host: + nc -l 4444 > syslog.log + +on guest: + ifconfig eth0 10.0.2.10/24 up + grep "" /tmp/syslog > /dev/tcp/10.0.2.2/4444 + +== To do +* The current list of logging requirements and tasks is maintained in bugzilla [https://bugzilla.redhat.com/show_bug.cgi?id=524980 524980]. +* A support for KVM's virtio logging is coming later [https://bugzilla.redhat.com/show_bug.cgi?id=576439 576439]. +