Skip site navigation (1)Skip section navigation (2)
Date:      Fri, 21 Aug 2015 05:24:46 -0700
From:      David Wolfskill <david@catwhisker.org>
To:        freebsd-ports@freebsd.org
Subject:   Transient(?) error: install for kernel module of multimedia/cuse4bsd-kmod
Message-ID:  <20150821122431.GT63584@albert.catwhisker.org>

next in thread | raw e-mail | index | archive | help

--/j2O6PQ6715aG3up
Content-Type: text/plain; charset=us-ascii
Content-Disposition: inline
Content-Transfer-Encoding: quoted-printable

This is slightly weird, so don't claim you weren't warned. :-}

It occurred during today's (daily) update of FreeBSD basse on my laptop.
The laptop was running:

FreeBSD g1-252.catwhisker.org 10.2-STABLE FreeBSD 10.2-STABLE #123  r286912=
M/286918:1002500: Wed Aug 19 04:05:06 PDT 2015     root@g1-252.catwhisker.o=
rg:/common/S1/obj/usr/src/sys/CANARY  amd64

at the time, and was being updated to r286961.  My ports tree was
(and is, as of this writing) head @r394934.

As some of the ports I have installed locally have kernel modules,
and as I rebuild the kernel often (daily, usually -- along with
userland and installed ports), I specify that the kernel update
should also rebuild the kernel modules of those ports (in /etc/src.conf):

g1-252(11.0-C)[2] grep PORT /etc/src.conf=20
PORTS_MODULES=3Dx11/nvidia-driver
PORTS_MODULES+=3Dmultimedia/cuse4bsd-kmod
PORTS_MODULES+=3Demulators/virtualbox-ose-kmod
g1-252(11.0-C)[3]=20

I perform the updates within script(1) so I have a record of what
happened, and keep the most recent 2 typescripts.

So, looking at yesterday's typescript (to set expectations), I see:

=2E..
>>> World build completed on Thu Aug 20 04:04:47 PDT 2015
>>> Kernel build for CANARY started on Thu Aug 20 04:04:47 PDT 2015
=3D=3D=3D> CANARY
>>> stage 1: configuring the kernel
>>> stage 2.2: rebuilding the object tree
=2E..
>>> stage 2.3: build tools
>>> stage 3.1: making dependencies
=2E..
>>> stage 3.2: building everything
=2E..
=3D=3D=3D> usb/template (all)
=3D=3D=3D> Ports module x11/nvidia-driver (all)
=3D=3D=3D>  Cleaning for nvidia-driver-346.47
=3D=3D=3D>  License NVIDIA accepted by the user
=2E..
=3D=3D=3D>  Configuring for nvidia-driver-346.47
=3D=3D=3D>  Building for nvidia-driver-346.47
=3D=3D=3D> src (all)
=2E..
=3D=3D=3D> doc (all)
=3D=3D=3D>  Staging for nvidia-driver-346.47
=3D=3D=3D>   nvidia-driver-346.47 depends on package: libGL>0 - found
=3D=3D=3D>   nvidia-driver-346.47 depends on file: /usr/local/libdata/pkgco=
nfig/xorg-server.pc - found
=3D=3D=3D>   Generating temporary packing list
=3D=3D=3D> src (install)
=2E..
ompressing man pages (compress-man)
=3D=3D=3D> Ports module multimedia/cuse4bsd-kmod (all)
=3D=3D=3D>  Cleaning for cuse4bsd-kmod-0.1.36
=3D=3D=3D>  Found saved configuration for cuse4bsd-kmod-0.1.35
=3D=3D=3D>   cuse4bsd-kmod-0.1.36 depends on file: /usr/local/sbin/pkg - fo=
und
=2E..
=3D=3D=3D=3D> Compressing man pages (compress-man)
=3D=3D=3D> Ports module emulators/virtualbox-ose-kmod (all)
=3D=3D=3D>  Cleaning for virtualbox-ose-kmod-4.3.30
=3D=3D=3D>  License GPLv2 accepted by the user
=3D=3D=3D>  Found saved configuration for virtualbox-ose-kmod-4.3.20
=3D=3D=3D>   virtualbox-ose-kmod-4.3.30 depends on file: /usr/local/sbin/pk=
g - found
=2E..
=3D=3D=3D> Staging rc.d startup script(s)
>>> Kernel build for CANARY completed on Thu Aug 20 04:05:44 PDT 2015
=3D=3D=3D>  Cleaning for nvidia-driver-346.47
>>> Installing kernel CANARY
=2E..
=3D=3D=3D> iscsi_initiator (install)
=3D=3D=3D> Ports module x11/nvidia-driver (install)
=3D=3D=3D>  Deinstalling for nvidia-driver
=3D=3D=3D>   Deinstalling nvidia-driver-346.47
=3D=3D=3D>  Installing for nvidia-driver-346.47
=3D=3D=3D>   nvidia-driver-346.47 depends on package: libGL>0 - found
=3D=3D=3D>   nvidia-driver-346.47 depends on file: /usr/local/libdata/pkgco=
nfig/xorg-server.pc - found
=2E..
=3D=3D=3D> Ports module multimedia/cuse4bsd-kmod (install)
=3D=3D=3D>  Deinstalling for cuse4bsd-kmod
=3D=3D=3D>   Deinstalling cuse4bsd-kmod-0.1.36
=3D=3D=3D>  Installing for cuse4bsd-kmod-0.1.36
=2E..
=3D=3D=3D> Ports module emulators/virtualbox-ose-kmod (install)
=3D=3D=3D>  Deinstalling for virtualbox-ose-kmod
=3D=3D=3D>   Deinstalling virtualbox-ose-kmod-4.3.30
=3D=3D=3D>  Installing for virtualbox-ose-kmod-4.3.30
=2E..
>>> Making hierarchy
>>> Installing everything
=3D=3D=3D> share/info (install)
=2E..
>>> Removing old files (only deletes safe to delete libs)
>>> Old files removed
>>> Removing old directories
=2E...


What happened this morning (the first time around) started the same,
but ended a bit prematurely:

=2E..
>>> World build completed on Fri Aug 21 04:07:02 PDT 2015
>>> Kernel build for CANARY started on Fri Aug 21 04:07:02 PDT 2015
=3D=3D=3D> CANARY
>>> stage 1: configuring the kernel
>>> stage 2.2: rebuilding the object tree
=2E..
>>> stage 2.3: build tools
>>> stage 3.1: making dependencies
=2E..
>>> stage 3.2: building everything
=2E..
=3D=3D=3D> usb/template (all)
=3D=3D=3D> Ports module x11/nvidia-driver (all)
=3D=3D=3D>  Cleaning for nvidia-driver-346.47
=3D=3D=3D>  License NVIDIA accepted by the user
=2E..
=3D=3D=3D>  Configuring for nvidia-driver-346.47
=3D=3D=3D>  Building for nvidia-driver-346.47
=3D=3D=3D> src (all)
=2E..
=3D=3D=3D> doc (all)
=3D=3D=3D>  Staging for nvidia-driver-346.47
=3D=3D=3D>   nvidia-driver-346.47 depends on package: libGL>0 - found
=3D=3D=3D>   nvidia-driver-346.47 depends on file: /usr/local/libdata/pkgco=
nfig/xorg-server.pc - found
=3D=3D=3D>   Generating temporary packing list
=3D=3D=3D> src (install)
=2E..
ompressing man pages (compress-man)
=3D=3D=3D> Ports module multimedia/cuse4bsd-kmod (all)
=3D=3D=3D>  Cleaning for cuse4bsd-kmod-0.1.36
=3D=3D=3D>  Found saved configuration for cuse4bsd-kmod-0.1.35
=3D=3D=3D>   cuse4bsd-kmod-0.1.36 depends on file: /usr/local/sbin/pkg - fo=
und
=2E..
=3D=3D=3D=3D> Compressing man pages (compress-man)
=3D=3D=3D> Ports module emulators/virtualbox-ose-kmod (all)
=3D=3D=3D>  Cleaning for virtualbox-ose-kmod-4.3.30
=3D=3D=3D>  License GPLv2 accepted by the user
=3D=3D=3D>  Found saved configuration for virtualbox-ose-kmod-4.3.20
=3D=3D=3D>   virtualbox-ose-kmod-4.3.30 depends on file: /usr/local/sbin/pk=
g - found
=2E..
=3D=3D=3D> Staging rc.d startup script(s)
>>> Kernel build for CANARY completed on Fri Aug 21 04:08:25 PDT 2015
=3D=3D=3D>  Cleaning for nvidia-driver-346.47
>>> Installing kernel CANARY
=2E..
=3D=3D=3D> iscsi_initiator (install)
=3D=3D=3D> Ports module x11/nvidia-driver (install)
=3D=3D=3D>  Deinstalling for nvidia-driver
=3D=3D=3D>   Deinstalling nvidia-driver-346.47
=3D=3D=3D>  Installing for nvidia-driver-346.47
=3D=3D=3D>   nvidia-driver-346.47 depends on package: libGL>0 - found
=3D=3D=3D>   nvidia-driver-346.47 depends on file: /usr/local/libdata/pkgco=
nfig/xorg-server.pc - found
=2E..
=3D=3D=3D> Ports module multimedia/cuse4bsd-kmod (install)
=3D=3D=3D>  Deinstalling for cuse4bsd-kmod
pkg-static: Cannot get an advisory lock on a database, it is locked by anot=
her process
*** Error code 75

Stop.
make[3]: stopped in /common/ports/multimedia/cuse4bsd-kmod
*** Error code 1

Stop.
make[2]: stopped in /common/S1/obj/usr/src/sys/CANARY
*** Error code 1

Stop.
make[1]: stopped in /usr/src
*** Error code 1

Stop.
make: stopped in /usr/src



Now, I promise I wasn't doing anything else with port-building at
the time.  Maybe there's a race condition?  Because the next thing I did
was (the equivalent of):

rm -fr /boot/modules.old && \
 cp -pr /boot/modules{,.old} && \
 make installkernel && \
 date && \
 pushd /usr/ports && \
 pushd x11/nvidia-driver && \
 make clean ; popd ; popd && \
 date && \
 mergemaster -U -u 0022 -p && \
 date && \
 rm -fr /usr/include.old && \
 date && \
 mv /usr/include{,.old} && \
 date && \
 rm -fr /usr/share/man && \
 date && \
 make installworld && \
 date && \
 mergemaster -F -U -u 0022 -i && \
 date && \
 make delete-old && \
 date && \
 df -k

[I use csh aliases to avoid the typing....]

And that worked (including the installation of the previously-build
ports kernel modules); the laptop successfully rebooted to:

FreeBSD g1-252.catwhisker.org 10.2-STABLE FreeBSD 10.2-STABLE #124  r286961=
M/286986:1002500: Fri Aug 21 04:07:13 PDT 2015     root@g1-252.catwhisker.o=
rg:/common/S1/obj/usr/src/sys/CANARY  amd64

I've been doing this with considerable (some might think "alarming")
frequency, and this morning is the first I recall encountering that
error report.

Peace,
david
--=20
David H. Wolfskill				david@catwhisker.org
Those who would murder in the name of God or prophet are blasphemous coward=
s.

See http://www.catwhisker.org/~david/publickey.gpg for my public key.

--/j2O6PQ6715aG3up
Content-Type: application/pgp-signature

-----BEGIN PGP SIGNATURE-----
Version: GnuPG v2

iQJ8BAEBCgBmBQJV1xiOXxSAAAAAAC4AKGlzc3Vlci1mcHJAbm90YXRpb25zLm9w
ZW5wZ3AuZmlmdGhob3JzZW1hbi5uZXQ4RThEMDY4QTIxMjc1MDZFRDIzODYzRTc4
QTY3RjlDOERFRjQxOTNCAAoJEIpn+cje9Bk7TtEP/jrxHKhLhLFbAIvThoHjEvxo
nXcAWtRd/fyMvpSEAo87s0betWnZv3EYVVIar6kkNJoxdIAFdttpIfF3lgtj353m
kqQvue9DLTeG6zwqgyWFd58wQkNZKafbkI3p912CNg4iTRlySgsWCpVrsZkNumfe
4TKWwO/N3bSjU5H/8neBF+f93EAT3r47YZ6Gkgj9iwax8aVzGM3yLxsEnTrTdVRl
D2qkQPO4jqqce6sTJlHChQhDeF7vfmnAWk1khGDY2SKXXocThIJNKRuvsy9FPTWF
TkGwPmXgsL6VTIpY5LA61T/+WyErmquOCJQSwo/JoLpQYyeUaDyOLX2tjcsHVcHl
FSnCOzPr2loKufOFIKCLoqBFvfoKcjRYSvGovWyFBOHOPSuNrVd748IRVLKaQ5rZ
UyKtDUFJChfoqGaTN63ISrUyGefYe85O7kRkUeofaB2mk/1PcE7FkvtOI+U2U8rS
wR3pXcsqtlcwH21lx8Kajog2e8fejBYLRo30N70eW68vcRceIwueo9ih1Fd9Ct+L
qDYZFVYfIlzbnD2fWo0aCaLym69WtkX2223M3qFNahTw5LiH62Cx6g4Mkg7KzTi/
YUUA1f8+l9D4cUFjbkx5n/piRrkzITpYTQZsEggajygQHpsvGfxBBuv3ExchnDYP
XOd4N1jAEbDslN27vJ4I
=GKwP
-----END PGP SIGNATURE-----

--/j2O6PQ6715aG3up--



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?20150821122431.GT63584>