• Bug#1091471: Full log (6/9)

    From Nicolas Cuissard@21:1/5 to All on Fri Dec 27 12:00:01 2024
    [continued from previous message]

    Dec 24 05:41:43 web-apo-test lvm[309]: Opened /dev/sda1 RO O_DIRECT
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sda1: size is 1992704 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: Closed /dev/sda1
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sda1: Device is a partition,
    using primary device sda for mpath component detection
    Dec 24 05:41:43 web-apo-test lvm[309]: filter caching good /dev/sda1
    Dec 24 05:41:43 web-apo-test lvm[309]: dm status (254:1) [ noopencount noflush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/vg0/sys: Skipping unusable
    device.
    Dec 24 05:41:43 web-apo-test lvm[309]: filter caching bad /dev/vg0/sys
    Dec 24 05:41:43 web-apo-test lvm[309]: Opened /dev/sda2 RO O_DIRECT
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sda2: size is 102367 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: Closed /dev/sda2
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sda2: Device is a partition,
    using primary device sda for mpath component detection
    Dec 24 05:41:43 web-apo-test lvm[309]: filter caching good /dev/sda2
    Dec 24 05:41:43 web-apo-test lvm[309]: Opened /dev/sdb RO O_DIRECT
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb: size is 62914560 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: Closed /dev/sdb
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info (254:1) [ noopencount
    noflush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: filter caching good /dev/sdb
    Dec 24 05:41:43 web-apo-test lvm[309]: Opened /dev/sdc RO O_DIRECT
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc: size is 33554432 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: Closed /dev/sdc
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info (254:0) [ noopencount
    noflush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: filter caching good /dev/sdc
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading hint file
    Dec 24 05:41:43 web-apo-test lvm[309]: devices/global_filter not found
    in config: defaulting to global_filter = [ "a|.*|" ]
    Dec 24 05:41:43 web-apo-test lvm[309]: devices/filter not found in
    config: defaulting to filter = [ "a|.*|" ]
    Dec 24 05:41:43 web-apo-test lvm[309]: add hint /dev/sdb 29iKZVoo686Tlxz9STnGUcjxw5PLKhI8 8:16 vg:vg0
    Dec 24 05:41:43 web-apo-test lvm[309]: add hint /dev/sdc 7dxZKu31lUeZcFJa0gWBdVgDRWTRTWWv 8:32 vg:swap
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sda: using cached size
    2097152 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sr0: Skipping: Unrecognised
    LVM device type 11
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sda1: using cached size
    1992704 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sda2: using cached size
    102367 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb: using cached size
    62914560 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc: using cached size
    33554432 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: accept hints found 2
    Dec 24 05:41:43 web-apo-test lvm[309]: get_hints: applied using 2 other 3
    Dec 24 05:41:43 web-apo-test lvm[309]: Checking fd limit for num_devs 2
    want 34 soft 1024 hard 524288
    Dec 24 05:41:43 web-apo-test lvm[309]: Scanning 2 devices for VG info
    Dec 24 05:41:43 web-apo-test lvm[309]: open /dev/sdb ro di 0 fd 6
    Dec 24 05:41:43 web-apo-test lvm[309]: open /dev/sdc ro di 1 fd 7
    Dec 24 05:41:43 web-apo-test lvm[309]: Scanning submitted 2 reads
    Dec 24 05:41:43 web-apo-test lvm[309]: Processing data from device
    /dev/sdb 8:16 di 0 block 0x55acf9ab3010
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb: using cached size
    62914560 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: dm-1(254:1): already checked as
    not being mpath.
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb: using cached size
    62914560 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: filter caching good /dev/sdb
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb: lvm2 label detected at
    sector 1
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdb: now in VG #orphans_lvm2 #orpha-ns_l-vm2
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb: PV header extension
    version 2 found
    Dec 24 05:41:43 web-apo-test lvm[309]: Scanning /dev/sdb mda1 summary.
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading mda header sector from
    /dev/sdb at 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading metadata summary from
    /dev/sdb at 8704 size 1650 (+0)
    Dec 24 05:41:43 web-apo-test lvm[309]: Found metadata summary on
    /dev/sdb at 8704 size 1650 for VG vg0
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache adding vginfo for vg0 C3EjL0-TcSU-61Da-gnD2-2xoa-LKio-sTDtKb
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdb: now in VG vg0 C3EjL0-TcSU-61Da-gnD2-2xoa-LKio-sTDtKb
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdb: VG vg0: set
    VGID to C3EjL0TcSU61DagnD22xoaLKiosTDtKb.
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdb mda1 VG vg0 set
    seqno 13 checksum b0015a25 mda_size 1650
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdb: VG vg0: set
    creation host to web-apo-test.
    Dec 24 05:41:43 web-apo-test lvm[309]: Scanned /dev/sdb mda1 seqno 13
    Dec 24 05:41:43 web-apo-test lvm[309]: Processing data from device
    /dev/sdc 8:32 di 1 block 0x55acf9ab3050
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc: using cached size
    33554432 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: dm-0(254:0): already checked as
    not being mpath.
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc: using cached size
    33554432 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: filter caching good /dev/sdc
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc: lvm2 label detected at
    sector 1
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdc: now in VG #orphans_lvm2 #orpha-ns_l-vm2
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc: PV header extension
    version 2 found
    Dec 24 05:41:43 web-apo-test lvm[309]: Scanning /dev/sdc mda1 summary.
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading mda header sector from
    /dev/sdc at 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading metadata summary from
    /dev/sdc at 4608 size 1007 (+0)
    Dec 24 05:41:43 web-apo-test lvm[309]: Found metadata summary on
    /dev/sdc at 4608 size 1007 for VG swap
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache adding vginfo for swap FLDx53-ANlQ-iq9L-iB04-iDbZ-eXPD-KGIW0A
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdc: now in VG swap FLDx53-ANlQ-iq9L-iB04-iDbZ-eXPD-KGIW0A
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdc: VG swap: set
    VGID to FLDx53ANlQiq9LiB04iDbZeXPDKGIW0A.
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdc mda1 VG swap
    set seqno 5 checksum 6d64cd3c mda_size 1007
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache /dev/sdc: VG swap: set
    creation host to web-apo-test.
    Dec 24 05:41:43 web-apo-test lvm[309]: Scanned /dev/sdc mda1 seqno 5
    Dec 24 05:41:43 web-apo-test lvm[309]: Scanned devices: read errors 0
    process errors 0 failed 0
    Dec 24 05:41:43 web-apo-test lvm[309]: Found VG info for 2 VGs
    Dec 24 05:41:43 web-apo-test lvm[309]: Obtaining the complete list of
    VGs to process
    Dec 24 05:41:43 web-apo-test lvm[309]: Processing VG swap FLDx53-ANlQ-iq9L-iB04-iDbZ-eXPD-KGIW0A
    Dec 24 05:41:43 web-apo-test lvm[309]: Locking /run/lock/lvm/V_swap RB
    Dec 24 05:41:43 web-apo-test lvm[309]: _do_flock /run/lock/lvm/V_swap:aux WB Dec 24 05:41:43 web-apo-test lvm[309]: _undo_flock /run/lock/lvm/V_swap:aux
    Dec 24 05:41:43 web-apo-test lvm[309]: _do_flock /run/lock/lvm/V_swap RB
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading VG swap FLDx53ANlQiq9LiB04iDbZeXPDKGIW0A
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading mda header sector from
    /dev/sdc at 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: 1 logical volume(s) in volume
    group "vg0" monitored
    Dec 24 05:41:43 web-apo-test lvm[309]: rescan skipped - unchanged offset
    512 checksum 6d64cd3c
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading VG swap metadata from
    /dev/sdc 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading mda header sector from
    /dev/sdc at 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: VG swap metadata check /dev/sdc
    mda 4096 slot0 offset 512 size 1007
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading metadata from /dev/sdc at
    4608 size 1007 (+0)
    Dec 24 05:41:43 web-apo-test lvm[309]: Allocated VG swap at 0x55acf9ad4610.
    Dec 24 05:41:43 web-apo-test lvm[309]: Importing logical volume swap/lv0.
    Dec 24 05:41:43 web-apo-test lvm[309]: Found metadata on /dev/sdc at
    4608 size 1007 for VG swap
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc: using cached size
    33554432 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache_update_vg swap for info /dev/sdc
    Dec 24 05:41:43 web-apo-test lvm[309]:
    metadata/lvs_history_retention_time not found in config: defaulting to 0
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdc 0: 0 4095: lv0(0:0)
    Dec 24 05:41:43 web-apo-test lvm[309]: Running command for VG swap FLDx53-ANlQ-iq9L-iB04-iDbZ-eXPD-KGIW0A
    Dec 24 05:41:43 web-apo-test lvm[309]: Getting device info for swap-lv0 [LVM-FLDx53ANlQiq9LiB04iDbZeXPDKGIW0AuUZxkawX3vSKIpjcHbPiAYlu28kYfHhB].
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info LVM-FLDx53ANlQiq9LiB04iDbZeXPDKGIW0AuUZxkawX3vSKIpjcHbPiAYlu28kYfHhB [ noopencount flush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: Counted 1 active LVs in VG swap
    Dec 24 05:41:43 web-apo-test lvm[309]: Getting device info for swap-lv0 [LVM-FLDx53ANlQiq9LiB04iDbZeXPDKGIW0AuUZxkawX3vSKIpjcHbPiAYlu28kYfHhB].
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info LVM-FLDx53ANlQiq9LiB04iDbZeXPDKGIW0AuUZxkawX3vSKIpjcHbPiAYlu28kYfHhB [ noopencount flush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: 1 logical volume(s) in volume
    group "swap" monitored
    Dec 24 05:41:43 web-apo-test lvm[309]: Unlock: Memlock counters:
    prioritized:0 locked:0 critical:0 daemon:0 suspended:0
    Dec 24 05:41:43 web-apo-test lvm[309]: Syncing device names
    Dec 24 05:41:43 web-apo-test lvm[309]: Unlocking /run/lock/lvm/V_swap
    Dec 24 05:41:43 web-apo-test lvm[309]: _undo_flock /run/lock/lvm/V_swap
    Dec 24 05:41:43 web-apo-test lvm[309]: Freeing VG swap at 0x55acf9ad4610.
    Dec 24 05:41:43 web-apo-test lvm[309]: Processing VG vg0 C3EjL0-TcSU-61Da-gnD2-2xoa-LKio-sTDtKb
    Dec 24 05:41:43 web-apo-test lvm[309]: Locking /run/lock/lvm/V_vg0 RB
    Dec 24 05:41:43 web-apo-test lvm[309]: _do_flock /run/lock/lvm/V_vg0:aux WB
    Dec 24 05:41:43 web-apo-test lvm[309]: _undo_flock /run/lock/lvm/V_vg0:aux
    Dec 24 05:41:43 web-apo-test lvm[309]: _do_flock /run/lock/lvm/V_vg0 RB
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading VG vg0 C3EjL0TcSU61DagnD22xoaLKiosTDtKb
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading mda header sector from
    /dev/sdb at 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: rescan skipped - unchanged offset
    4608 checksum b0015a25
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading VG vg0 metadata from
    /dev/sdb 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading mda header sector from
    /dev/sdb at 4096
    Dec 24 05:41:43 web-apo-test lvm[309]: VG vg0 metadata check /dev/sdb
    mda 4096 slot0 offset 4608 size 1650
    Dec 24 05:41:43 web-apo-test blkmapd[333]: open pipe file /run/rpc_pipefs/nfs/blocklayout failed: No such file or directory
    Dec 24 05:41:43 web-apo-test lvm[309]: Reading metadata from /dev/sdb at
    8704 size 1650 (+0)
    Dec 24 05:41:43 web-apo-test lvm[309]: Allocated VG vg0 at 0x55acf9ad4610.
    Dec 24 05:41:43 web-apo-test lvm[309]: Importing logical volume vg0/sys.
    Dec 24 05:41:43 web-apo-test lvm[309]: Importing logical volume vg0/home.
    Dec 24 05:41:43 web-apo-test lvm[309]: Found metadata on /dev/sdb at
    8704 size 1650 for VG vg0
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb: size is 62914560 sectors
    Dec 24 05:41:43 web-apo-test lvm[309]: lvmcache_update_vg vg0 for info
    /dev/sdb
    Dec 24 05:41:43 web-apo-test lvm[309]:
    metadata/lvs_history_retention_time not found in config: defaulting to 0
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb 0: 0 1024: sys(0:0)
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb 1: 1024 1025:
    home(1023:0)
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb 2: 2049 1023:
    sys(1024:0)
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb 3: 3072 1023: home(0:0)
    Dec 24 05:41:43 web-apo-test lvm[309]: /dev/sdb 4: 4095 3584:
    home(2048:0)
    Dec 24 05:41:43 web-apo-test lvm[309]: Running command for VG vg0 C3EjL0-TcSU-61Da-gnD2-2xoa-LKio-sTDtKb
    Dec 24 05:41:43 web-apo-test lvm[309]: Getting device info for vg0-sys [LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbM6Sfe3nVKa9tKxIq6njKzKMEmrky1JKw].
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbM6Sfe3nVKa9tKxIq6njKzKMEmrky1JKw [ noopencount flush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: Getting device info for vg0-home [LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbkKpuWX5We5YAUqkZUk5H4ItgdmAsofSL].
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbkKpuWX5We5YAUqkZUk5H4ItgdmAsofSL [ noopencount flush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: Skipping checks for old devices
    without LVM- dm uuid prefix (kernel vsn 5 >= 3).
    Dec 24 05:41:43 web-apo-test lvm[309]: Counted 1 active LVs in VG vg0
    Dec 24 05:41:43 web-apo-test lvm[309]: Getting device info for vg0-sys [LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbM6Sfe3nVKa9tKxIq6njKzKMEmrky1JKw].
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbM6Sfe3nVKa9tKxIq6njKzKMEmrky1JKw [ noopencount flush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: Getting device info for vg0-home [LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbkKpuWX5We5YAUqkZUk5H4ItgdmAsofSL].
    Dec 24 05:41:43 web-apo-test lvm[309]: dm info LVM-C3EjL0TcSU61DagnD22xoaLKiosTDtKbkKpuWX5We5YAUqkZUk5H4ItgdmAsofSL [ noopencount flush enablechecks ] [16384] (*1)
    Dec 24 05:41:43 web-apo-test lvm[309]: 1 logical volume(s) in volume
    group "vg0" monitored
    Dec 24 05:41:43 web-apo-test lvm[309]: Unlock: Memlock counters:
    prioritized:0 locked:0 critical:0 daemon:0 suspended:0
    Dec 24 05:41:43 web-apo-test lvm[309]: Syncing device names
    Dec 24 05:41:43 web-apo-test lvm[309]: Unlocking /run/lock/lvm/V_vg0
    Dec 24 05:41:43 web-apo-test lvm[309]: _undo_flock /run/lock/lvm/V_vg0
    Dec 24 05:41:43 web-apo-test lvm[309]: Freeing VG vg0 at 0x55acf9ad4610.
    Dec 24 05:41:43 web-apo-test lvm[309]: Unlocking /run/lock/lvm/P_global
    Dec 24 05:41:43 web-apo-test lvm[309]: _undo_flock /run/lock/lvm/P_global
    Dec 24 05:41:43 web-apo-test lvm[309]: Destroy lvmcache content
    Dec 24 05:41:43 web-apo-test systemd-journald[314]: Runtime Journal (/run/log/journal/2b298e9623d74b8f96361ba7f8bcf931) is 6.2M, max 50.0M,
    43.7M free.
    -- Subject: Disk space used by the journal
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- Runtime Journal (/run/log/journal/2b298e9623d74b8f96361ba7f8bcf931)
    is currently using 6.2M.
    -- Maximum allowed usage is set to 50.0M.
    -- Leaving at least 89.7M free (of currently available 1.7G of disk space).
    -- Enforced usage limit is thus 50.0M, of which 43.7M are still available.
    --
    -- The limits controlling how much disk space is used by the journal may
    -- be configured with SystemMaxUse=, SystemKeepFree=, SystemMaxFileSize=,
    -- RuntimeMaxUse=, RuntimeKeepFree=, RuntimeMaxFileSize= settings in
    -- /etc/systemd/journald.conf. See journald.conf(5) for details.
    Dec 24 05:41:43 web-apo-test systemd[1]: Finished Flush Journal to
    Persistent Storage.
    -- Subject: A start job for unit systemd-journal-flush.service has
    finished successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit systemd-journal-flush.service has finished successfully.
    --
    -- The job identifier is 41.
    Dec 24 05:41:43 web-apo-test systemd[1]: Finished Create Static Device
    Nodes in /dev.
    -- Subject: A start job for unit systemd-tmpfiles-setup-dev.service has finished successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit systemd-tmpfiles-setup-dev.service has finished successfully.
    --
    -- The job identifier is 34.
    Dec 24 05:41:43 web-apo-test systemd[1]: Starting Rule-based Manager for
    Device Events and Files...
    -- Subject: A start job for unit systemd-udevd.service has begun execution
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit systemd-udevd.service has begun execution.
    --
    -- The job identifier is 22.
    Dec 24 05:41:43 web-apo-test systemd-udevd[339]: Network interface
    NamePolicy= disabled on kernel command line, ignoring.
    Dec 24 05:41:43 web-apo-test systemd-udevd[339]: /etc/systemd/network/99-default.link: No valid settings found in the
    [Match] section, ignoring file. To match all interfaces, add
    OriginalName=* in the [Match] section.
    Dec 24 05:41:43 web-apo-test systemd[1]: Finished Coldplug All udev Devices.
    -- Subject: A start job for unit systemd-udev-trigger.service has
    finished successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit systemd-udev-trigger.service has finished
    successfully.
    --
    -- The job identifier is 21.
    Dec 24 05:41:43 web-apo-test systemd[1]: Starting Helper to synchronize
    boot up for ifupdown...
    -- Subject: A start job for unit ifupdown-pre.service has begun execution
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit ifupdown-pre.service has begun execution.
    --
    -- The job identifier is 91.
    Dec 24 05:41:43 web-apo-test systemd[1]: Started Rule-based Manager for
    Device Events and Files.
    -- Subject: A start job for unit systemd-udevd.service has finished successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit systemd-udevd.service has finished successfully.
    --
    -- The job identifier is 22.
    Dec 24 05:41:43 web-apo-test lvm[309]: Completed: vgchange --monitor y
    Dec 24 05:41:43 web-apo-test lvm[309]: Destroy lvmcache content
    Dec 24 05:41:43 web-apo-test lvm[309]: Freeing VG #orphans_lvm2 at 0x55acf929ca30.
    Dec 24 05:41:43 web-apo-test lvm[309]: Syncing device names
    Dec 24 05:41:43 web-apo-test systemd[1]: Finished Monitoring of LVM2
    mirrors, snapshots etc. using dmeventd or progress polling.
    -- Subject: A start job for unit lvm2-monitor.service has finished
    successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit lvm2-monitor.service has finished successfully.
    --
    -- The job identifier is 19.
    Dec 24 05:41:43 web-apo-test systemd[1]: Reached target Local File
    Systems (Pre).
    -- Subject: A start job for unit local-fs-pre.target has finished
    successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit local-fs-pre.target has finished successfully.
    --
    -- The job identifier is 36.
    Dec 24 05:41:43 web-apo-test kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4
    Dec 24 05:41:43 web-apo-test kernel: ACPI: AC Adapter [ACAD] (on-line)
    Dec 24 05:41:43 web-apo-test kernel: ACPI: Power Button [PWRF]
    Dec 24 05:41:43 web-apo-test kernel: vmw_vmci 0000:00:07.7: enabling
    device (0000 -> 0003)
    Dec 24 05:41:43 web-apo-test kernel: input: PC Speaker as /devices/platform/pcspkr/input/input5
    Dec 24 05:41:43 web-apo-test kernel: vmw_vmci 0000:00:07.7: Found VMCI
    PCI device at 0x12000, irq 16
    Dec 24 05:41:43 web-apo-test systemd-udevd[350]: Using default interface
    naming scheme 'v247'.
    Dec 24 05:41:43 web-apo-test kernel: vmw_vmci 0000:00:07.7: Using
    capabilities 0x1c
    Dec 24 05:41:43 web-apo-test kernel: pstore: Using crash dump
    compression: deflate
    Dec 24 05:41:43 web-apo-test kernel: pstore: Registered efi as
    persistent store backend
    Dec 24 05:41:43 web-apo-test kernel: sd 0:0:0:0: Attached scsi generic
    sg0 type 0
    Dec 24 05:41:43 web-apo-test kernel: sd 0:0:1:0: Attached scsi generic
    sg1 type 0
    Dec 24 05:41:43 web-apo-test kernel: sd 0:0:2:0: Attached scsi generic
    sg2 type 0
    Dec 24 05:41:43 web-apo-test kernel: Guest personality initialized and
    is active
    Dec 24 05:41:43 web-apo-test kernel: sr 2:0:0:0: Attached scsi generic
    sg3 type 5
    Dec 24 05:41:43 web-apo-test systemd-udevd[349]: ethtool:
    autonegotiation is unset or enabled, the speed and duplex are not writable.
    Dec 24 05:41:43 web-apo-test systemd-udevd[350]: ethtool:
    autonegotiation is unset or enabled, the speed and duplex are not writable.
    Dec 24 05:41:43 web-apo-test kernel: RAPL PMU: API unit is 2^-32 Joules,
    0 fixed counters, 10737418240 ms ovfl timer
    Dec 24 05:41:43 web-apo-test kernel: VMCI host device registered
    (name=vmci, major=10, minor=61)
    Dec 24 05:41:43 web-apo-test kernel: Initialized host personality
    Dec 24 05:41:43 web-apo-test systemd[1]: Created slice system-lvm2\x2dpvscan.slice.
    -- Subject: A start job for unit system-lvm2\x2dpvscan.slice has
    finished successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit system-lvm2\x2dpvscan.slice has finished
    successfully.
    --
    -- The job identifier is 156.
    Dec 24 05:41:43 web-apo-test systemd[1]: Starting LVM event activation
    on device 8:16...
    -- Subject: A start job for unit lvm2-pvscan@8:16.service has begun
    execution
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit lvm2-pvscan@8:16.service has begun execution.
    --
    -- The job identifier is 155.
    Dec 24 05:41:43 web-apo-test systemd[1]: Starting LVM event activation
    on device 8:32...
    -- Subject: A start job for unit lvm2-pvscan@8:32.service has begun
    execution
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit lvm2-pvscan@8:32.service has begun execution.
    --
    -- The job identifier is 167.
    Dec 24 05:41:43 web-apo-test lvm[399]: Setting log/debug_classes to debug_classes = [ "memory", "devices", "io", "activation", "allocation", "metadata", "cache", "locking", "lvmpolld", "dbus" ]
    Dec 24 05:41:43 web-apo-test lvm[399]: Setting log debug classes to 2031
    Dec 24 05:41:43 web-apo-test lvm[399]: Logging initialised at Tue Dec
    24 05:41:43 2024
    Dec 24 05:41:43 web-apo-test lvm[399]: log/debug_file_fields not found
    in config: defaulting to debug_file_fields = [ "time", "command",
    "fileline", "message" ]
    Dec 24 05:41:43 web-apo-test lvm[399]: Set umask from 0022 to 0077
    Dec 24 05:41:43 web-apo-test lvm[399]: log/debug_output_fields not found
    in config: defaulting to debug_output_fields = [ "time", "command",
    "fileline", "message" ]
    Dec 24 05:41:43 web-apo-test lvm[399]: Logging initialised at Tue Dec 24 05:41:43 2024
    Dec 24 05:41:43 web-apo-test lvm[399]: Loading config file: /etc/lvm/lvmlocal.conf
    Dec 24 05:41:43 web-apo-test lvm[399]: Opened /etc/lvm/lvmlocal.conf RO
    Dec 24 05:41:43 web-apo-test lvm[399]: Closed /etc/lvm/lvmlocal.conf
    Dec 24 05:41:43 web-apo-test lvm[399]: Set umask from 0022 to 0077
    Dec 24 05:41:43 web-apo-test lvm[399]:
    activation/auto_set_activation_skip not found in config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[399]: activation/readahead not found in config: defaulting to auto
    Dec 24 05:41:43 web-apo-test lvm[399]: LVM activation checks enabled
    Dec 24 05:41:43 web-apo-test lvm[399]: activation/use_linear_target not
    found in config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[399]: report/binary_values_as_numeric
    not found in config: defaulting to 0
    Dec 24 05:41:43 web-apo-test lvm[399]: report/mark_hidden_devices not
    found in config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[399]: report/list_item_separator not
    found in config: defaulting to ,
    Dec 24 05:41:43 web-apo-test lvm[399]: report/time_format not found in
    config: defaulting to %Y-%m-%d %T %z
    Dec 24 05:41:43 web-apo-test lvm[399]: report/two_word_unknown_device
    not found in config: defaulting to 0
    Dec 24 05:41:43 web-apo-test lvm[399]: global/io_memory_size not found
    in config: defaulting to 8192
    Dec 24 05:41:43 web-apo-test lvm[399]: global/use_aio not found in
    config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[399]: devices/preferred_names not found
    in config: using built-in preferences
    Dec 24 05:41:43 web-apo-test lvm[399]: Setting devices/scan to scan = [
    "/dev" ]
    Dec 24 05:41:43 web-apo-test lvm[399]: activation/reserved_stack not
    found in config: defaulting to 64
    Dec 24 05:41:43 web-apo-test lvm[399]: activation/reserved_memory not
    found in config: defaulting to 8192
    Dec 24 05:41:43 web-apo-test lvm[399]: activation/process_priority not
    found in config: defaulting to -18
    Dec 24 05:41:43 web-apo-test lvm[399]: Allocated VG #orphans_lvm2 at 0x559e583e2a30.
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised format: lvm2
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: linear
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: striped
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: zero
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: error
    Dec 24 05:41:43 web-apo-test lvm[399]: dmeventd/snapshot_library not
    found in config: defaulting to libdevmapper-event-lvm2snapshot.so
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: snapshot
    Dec 24 05:41:43 web-apo-test lvm[399]: dmeventd/mirror_library not found
    in config: defaulting to libdevmapper-event-lvm2mirror.so
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: mirror
    Dec 24 05:41:43 web-apo-test lvm[399]: dmeventd/raid_library not found
    in config: defaulting to libdevmapper-event-lvm2raid.so
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid0
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid0_meta
    Dec 24 05:41:43 web-apo-test systemd[1]: Found device /dev/mapper/swap-lv0.
    -- Subject: A start job for unit dev-mapper-swap\x2dlv0.device has
    finished successfully
    -- Defined-By: systemd
    -- Support: https://www.debian.org/support
    --
    -- A start job for unit dev-mapper-swap\x2dlv0.device has finished successfully.
    --
    -- The job identifier is 51.
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid1
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid10
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid10_near
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid4
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid5
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid5_n
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid5_la
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid5_ls
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid5_ra
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid5_rs
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_n_6
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_nc
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_nr
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_zr
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_ls_6
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_rs_6
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_la_6
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: raid6_ra_6
    Dec 24 05:41:43 web-apo-test lvm[399]: dmeventd/thin_library not found
    in config: defaulting to libdevmapper-event-lvm2thin.so
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: thin-pool
    Dec 24 05:41:43 web-apo-test lvm[399]: dmeventd/thin_library not found
    in config: defaulting to libdevmapper-event-lvm2thin.so
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: thin
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: cache-pool
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: cache
    Dec 24 05:41:43 web-apo-test lvm[399]: dmeventd/vdo_library not found in config: defaulting to libdevmapper-event-lvm2vdo.so
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtypes: vdo, vdo-pool.
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: writecache
    Dec 24 05:41:43 web-apo-test lvm[399]: Initialised segtype: integrity
    Dec 24 05:41:43 web-apo-test lvm[400]: Setting log/debug_classes to debug_classes = [ "memory", "devices", "io", "activation", "allocation", "metadata", "cache", "locking", "lvmpolld", "dbus" ]
    Dec 24 05:41:43 web-apo-test lvm[400]: Setting log debug classes to 2031
    Dec 24 05:41:43 web-apo-test lvm[400]: Logging initialised at Tue Dec
    24 05:41:43 2024
    Dec 24 05:41:43 web-apo-test lvm[400]: log/debug_file_fields not found
    in config: defaulting to debug_file_fields = [ "time", "command",
    "fileline", "message" ]
    Dec 24 05:41:43 web-apo-test lvm[400]: log/debug_output_fields not found
    in config: defaulting to debug_output_fields = [ "time", "command",
    "fileline", "message" ]
    Dec 24 05:41:43 web-apo-test lvm[400]: Set umask from 0022 to 0077
    Dec 24 05:41:43 web-apo-test lvm[400]: Logging initialised at Tue Dec 24 05:41:43 2024
    Dec 24 05:41:43 web-apo-test lvm[400]: Loading config file: /etc/lvm/lvmlocal.conf
    Dec 24 05:41:43 web-apo-test lvm[400]: Opened /etc/lvm/lvmlocal.conf RO
    Dec 24 05:41:43 web-apo-test lvm[400]: Closed /etc/lvm/lvmlocal.conf
    Dec 24 05:41:43 web-apo-test lvm[399]: Parsing: pvscan --cache
    --activate ay 8:16
    Dec 24 05:41:43 web-apo-test lvm[399]: Recognised command pvscan_cache
    (id 124 / enum 104).
    Dec 24 05:41:43 web-apo-test lvm[399]: Sysfs filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: Internal filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: LVM type filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: Usable device filter initialised (scan_lvs 0).
    Dec 24 05:41:43 web-apo-test lvm[400]: Set umask from 0022 to 0077
    Dec 24 05:41:43 web-apo-test lvm[399]: mpath filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: Partitioned filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: signature filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: MD filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: Composite filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: Persistent filter initialised.
    Dec 24 05:41:43 web-apo-test lvm[399]: devices/hints not found in
    config: defaulting to all
    Dec 24 05:41:43 web-apo-test lvm[399]: metadata/record_lvs_history not
    found in config: defaulting to 0
    Dec 24 05:41:43 web-apo-test lvm[399]: DEGRADED MODE. Incomplete RAID
    LVs will be processed.
    Dec 24 05:41:43 web-apo-test lvm[399]: Processing command: pvscan
    --cache --activate ay 8:16
    Dec 24 05:41:43 web-apo-test lvm[399]: Command pid: 399
    Dec 24 05:41:43 web-apo-test lvm[399]: System ID:
    Dec 24 05:41:43 web-apo-test lvm[399]: O_DIRECT will be used
    Dec 24 05:41:43 web-apo-test lvm[399]: global/locking_type not found in
    config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[399]: File locking settings: readonly:0 sysinit:0 ignorelockingfailure:0 global/metadata_read_only:0 global/wait_for_locks:1.
    Dec 24 05:41:43 web-apo-test lvm[400]:
    activation/auto_set_activation_skip not found in config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[399]: devices/md_component_checks not
    found in config: defaulting to auto
    Dec 24 05:41:43 web-apo-test lvm[400]: activation/readahead not found in config: defaulting to auto
    Dec 24 05:41:43 web-apo-test lvm[399]: Using md_component_checks auto use_full_md_check 0
    Dec 24 05:41:43 web-apo-test lvm[400]: LVM activation checks enabled
    Dec 24 05:41:43 web-apo-test lvm[400]: activation/use_linear_target not
    found in config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[399]: Creating list of system devices.
    Dec 24 05:41:43 web-apo-test lvm[400]: report/binary_values_as_numeric
    not found in config: defaulting to 0
    Dec 24 05:41:43 web-apo-test lvm[400]: report/mark_hidden_devices not
    found in config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[400]: report/list_item_separator not
    found in config: defaulting to ,
    Dec 24 05:41:43 web-apo-test lvm[400]: report/time_format not found in
    config: defaulting to %Y-%m-%d %T %z
    Dec 24 05:41:43 web-apo-test lvm[400]: report/two_word_unknown_device
    not found in config: defaulting to 0
    Dec 24 05:41:43 web-apo-test lvm[400]: global/io_memory_size not found
    in config: defaulting to 8192
    Dec 24 05:41:43 web-apo-test lvm[400]: global/use_aio not found in
    config: defaulting to 1
    Dec 24 05:41:43 web-apo-test lvm[400]: devices/preferred_names not found

    [continued in next message]

    --- SoupGate-Win32 v1.05
    * Origin: fsxNet Usenet Gateway (21:1/5)