dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install...

public inbox for isar-users@googlegroups.com
 help / color / mirror / Atom feed

* dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install...
@ 2019-08-26 20:22 Jan Kiszka
  2019-08-26 20:59 ` Baurzhan Ismagulov
  0 siblings, 1 reply; 4+ messages in thread
From: Jan Kiszka @ 2019-08-26 20:22 UTC (permalink / raw)
  To: isar-users

Hi all,

any one any idea what could cause this?

2019-08-26 19:12:59 - ERROR    - ERROR: mc:ultra96-jailhouse-demo:demo-image-1.0-r0 do_rootfs_install: Function failed: rootfs_install_pkgs_install (log file is located at /builds/ebsy/debian/build/tmp/work/jailhouse-demo-arm64/demo-image-ultra96-wic-img/1.0-r0/temp/log.do_rootfs_install.60341)
[...]
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_install_pkgs_install
[...]
2019-08-26 19:12:59 - INFO     - | Get:7 file:/isar-apt isar/main arm64 u-boot-tools arm64 2019.01-atf1.6 [93.1 kB]
[...]
2019-08-26 19:12:59 - INFO     - | Setting up python-minimal (2.7.13-2) ...
2019-08-26 19:12:59 - INFO     - | dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install-iVLVJB/57-u-boot-tools_2019.01-atf1.6_arm64.deb': No such file or directory
2019-08-26 19:12:59 - INFO     - | E: Sub-process /usr/bin/dpkg returned an error code (2)

This is the target image rootfs_install. As such, it works in an 
exclusive chroot, nothing shared to my best knowledge. apt downloaded 
that locally built package before, then tries to install it but seems to
stumble over the temporary package file suddenly disappearing. Full log 
of the failing task below.

I've seen this pattern now twice in a lot of builds, and it still makes 
no sense to me (in contrast to wic-related issue for which a patch will 
follow soon).

Jan

---

2019-08-26 19:06:20 - INFO     - NOTE: recipe demo-image-1.0-r0: task do_rootfs_install: Started
2019-08-26 19:12:59 - ERROR    - ERROR: mc:ultra96-jailhouse-demo:demo-image-1.0-r0 do_rootfs_install: Function failed: rootfs_install_pkgs_install (log file is located at /builds/ebsy/debian/build/tmp/work/jailhouse-demo-arm64/demo-image-ultra96-wic-img/1.0-r0/temp/log.do_rootfs_install.60341)
2019-08-26 19:12:59 - ERROR    - ERROR: Logfile of failure stored in: /builds/ebsy/debian/build/tmp/work/jailhouse-demo-arm64/demo-image-ultra96-wic-img/1.0-r0/temp/log.do_rootfs_install.60341
2019-08-26 19:12:59 - INFO     - Log data follows:
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing python function do_rootfs_install
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function root_cleandirs
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function root_cleandirs finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_prepare
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function rootfs_prepare finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_configure_isar_apt
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function rootfs_configure_isar_apt finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function image_configure_accounts
2019-08-26 19:12:59 - INFO     - | Do not execute usermod (no changes).
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function image_configure_accounts finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function image_configure_fstab
2019-08-26 19:12:59 - INFO     - | # Begin /etc/fstab
2019-08-26 19:12:59 - INFO     - | /dev/root	/		auto		defaults		0	0
2019-08-26 19:12:59 - INFO     - | proc		/proc		proc		nosuid,noexec,nodev	0	0
2019-08-26 19:12:59 - INFO     - | sysfs		/sys		sysfs		nosuid,noexec,nodev	0	0
2019-08-26 19:12:59 - INFO     - | devpts		/dev/pts	devpts		gid=5,mode=620		0	0
2019-08-26 19:12:59 - INFO     - | tmpfs		/run		tmpfs		defaults		0	0
2019-08-26 19:12:59 - INFO     - | devtmpfs	/dev		devtmpfs	mode=0755,nosuid	0	0
2019-08-26 19:12:59 - INFO     - |
2019-08-26 19:12:59 - INFO     - | # End /etc/fstab
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function image_configure_fstab finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_do_mounts
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function rootfs_do_mounts finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_install_pkgs_update
2019-08-26 19:12:59 - INFO     - | Get:1 file:/isar-apt isar InRelease
2019-08-26 19:12:59 - INFO     - | Ign:1 file:/isar-apt isar InRelease
2019-08-26 19:12:59 - INFO     - | Get:2 file:/isar-apt isar Release [4314 B]
2019-08-26 19:12:59 - INFO     - | Get:2 file:/isar-apt isar Release [4314 B]
2019-08-26 19:12:59 - INFO     - | Get:3 file:/isar-apt isar Release.gpg
2019-08-26 19:12:59 - INFO     - | Ign:3 file:/isar-apt isar Release.gpg
2019-08-26 19:12:59 - INFO     - | Get:4 file:/isar-apt isar/main arm64 Packages [2774 B]
2019-08-26 19:12:59 - INFO     - | Reading package lists...
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function rootfs_install_pkgs_update finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_install_resolvconf
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function rootfs_install_resolvconf finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_install_pkgs_download
2019-08-26 19:12:59 - INFO     - | Reading package lists...
2019-08-26 19:12:59 - INFO     - | Building dependency tree...
2019-08-26 19:12:59 - INFO     - | Reading state information...
2019-08-26 19:12:59 - INFO     - | Starting pkgProblemResolver with broken count: 0
2019-08-26 19:12:59 - INFO     - | Starting 2 pkgProblemResolver with broken count: 0
2019-08-26 19:12:59 - INFO     - | Done
2019-08-26 19:12:59 - INFO     - | The following additional packages will be installed:
2019-08-26 19:12:59 - INFO     - |   bsdmainutils cpio dmsetup groff-base initramfs-tools initramfs-tools-core
2019-08-26 19:12:59 - INFO     - |   iproute2 klibc-utils kmod libapparmor1 libbsd0 libcap2 libcryptsetup4
2019-08-26 19:12:59 - INFO     - |   libdbus-1-3 libdevmapper1.02.1 libdns-export162 libedit2 libelf1 libexpat1
2019-08-26 19:12:59 - INFO     - |   libffi6 libgdbm3 libgpm2 libgssapi-krb5-2 libidn11 libip4tc0 libiperf0
2019-08-26 19:12:59 - INFO     - |   libisc-export160 libiw30 libk5crypto3 libkeyutils1 libklibc libkmod2
2019-08-26 19:12:59 - INFO     - |   libkrb5-3 libkrb5support0 libmnl0 libncurses5 libnettle6 libnl-3-200
2019-08-26 19:12:59 - INFO     - |   libnl-genl-3-200 libpci3 libpcsclite1 libpipeline1 libprocps6
2019-08-26 19:12:59 - INFO     - |   libpython-stdlib libpython2.7-minimal libpython2.7-stdlib libreadline7
2019-08-26 19:12:59 - INFO     - |   libseccomp2 libsqlite3-0 libssl1.0.2 libssl1.1 libusb-1.0-0 libwrap0
2019-08-26 19:12:59 - INFO     - |   linux-base mime-support openssh-client openssh-server openssh-sftp-server
2019-08-26 19:12:59 - INFO     - |   procps python python-mako python-markupsafe python-minimal python2.7
2019-08-26 19:12:59 - INFO     - |   python2.7-minimal readline-common systemd systemd-sysv u-boot-tools ucf udev
2019-08-26 19:12:59 - INFO     - |   vim-common vim-runtime xxd
2019-08-26 19:12:59 - INFO     - | Suggested packages:
2019-08-26 19:12:59 - INFO     - |   cpp wamerican | wordlist whois vacation libarchive1 groff ppp rdnssd
2019-08-26 19:12:59 - INFO     - |   iproute2-doc resolvconf avahi-autoipd isc-dhcp-client-ddns gpm krb5-doc
2019-08-26 19:12:59 - INFO     - |   krb5-user pcscd www-browser spell keychain libpam-ssh monkeysphere
2019-08-26 19:12:59 - INFO     - |   ssh-askpass molly-guard rssh ufw bzip2 wget | curl | lynx-cur python-doc
2019-08-26 19:12:59 - INFO     - |   python-tk python-beaker python-mako-doc python2.7-doc binutils
2019-08-26 19:12:59 - INFO     - |   binfmt-support readline-doc systemd-ui systemd-container policykit-1 wget
2019-08-26 19:12:59 - INFO     - |   | lynx-cur ctags vim-doc vim-scripts wpagui libengine-pkcs11-openssl
2019-08-26 19:12:59 - INFO     - | Recommended packages:
2019-08-26 19:12:59 - INFO     - |   busybox | busybox-static libatm1 libxtables12 libcap2-bin isc-dhcp-common
2019-08-26 19:12:59 - INFO     - |   crda dbus krb5-locales tcpd bzip2 file xz-utils xauth libpam-systemd
2019-08-26 19:12:59 - INFO     - |   ncurses-term psmisc
2019-08-26 19:12:59 - INFO     - | The following NEW packages will be installed:
2019-08-26 19:12:59 - INFO     - |   bash-completion bsdmainutils cpio customizations-ultra96 dmsetup ethtool
2019-08-26 19:12:59 - INFO     - |   expand-on-first-boot firmware-ti-connectivity groff-base ifupdown init
2019-08-26 19:12:59 - INFO     - |   initramfs-tools initramfs-tools-core iperf3 iproute2 iputils-ping
2019-08-26 19:12:59 - INFO     - |   isc-dhcp-client iw jailhouse-jailhouse klibc-utils kmod less libapparmor1
2019-08-26 19:12:59 - INFO     - |   libbsd0 libcap2 libcryptsetup4 libdbus-1-3 libdevmapper1.02.1
2019-08-26 19:12:59 - INFO     - |   libdns-export162 libedit2 libelf1 libexpat1 libffi6 libgdbm3 libgpm2
2019-08-26 19:12:59 - INFO     - |   libgssapi-krb5-2 libidn11 libip4tc0 libiperf0 libisc-export160 libiw30
2019-08-26 19:12:59 - INFO     - |   libk5crypto3 libkeyutils1 libklibc libkmod2 libkrb5-3 libkrb5support0
2019-08-26 19:12:59 - INFO     - |   libmnl0 libncurses5 libnettle6 libnl-3-200 libnl-genl-3-200 libpci3
2019-08-26 19:12:59 - INFO     - |   libpcsclite1 libpipeline1 libprocps6 libpython-stdlib libpython2.7-minimal
2019-08-26 19:12:59 - INFO     - |   libpython2.7-stdlib libreadline7 libseccomp2 libsqlite3-0 libssl1.0.2
2019-08-26 19:12:59 - INFO     - |   libssl1.1 libusb-1.0-0 libwrap0 linux-base linux-image-jailhouse man-db
2019-08-26 19:12:59 - INFO     - |   mime-support nano net-tools non-root-initramfs openssh-client openssh-server
2019-08-26 19:12:59 - INFO     - |   openssh-sftp-server pciutils procps python python-mako python-markupsafe
2019-08-26 19:12:59 - INFO     - |   python-minimal python2.7 python2.7-minimal readline-common ssh
2019-08-26 19:12:59 - INFO     - |   sshd-regen-keys systemd systemd-sysv u-boot-script u-boot-tools ucf udev
2019-08-26 19:12:59 - INFO     - |   usbutils vim vim-common vim-runtime wireless-tools wpasupplicant xxd
2019-08-26 19:12:59 - INFO     - | 0 upgraded, 100 newly installed, 0 to remove and 0 not upgraded.
2019-08-26 19:12:59 - INFO     - | Need to get 29.3 MB/39.3 MB of archives.
2019-08-26 19:12:59 - INFO     - | After this operation, 147 MB of additional disk space will be used.
2019-08-26 19:12:59 - INFO     - | Get:7 http://ftp.debian.org/debian stretch/main arm64 libapparmor1 arm64 2.11.0-3+deb9u2 [75.7 kB]
2019-08-26 19:12:59 - INFO     - | Get:9 file:/isar-apt isar/main arm64 linux-image-jailhouse arm64 4.19.67-1 [7802 kB]
2019-08-26 19:12:59 - INFO     - | Get:10 file:/isar-apt isar/main arm64 customizations-ultra96 arm64 1.0 [2914 B]
2019-08-26 19:12:59 - INFO     - | Get:11 file:/isar-apt isar/main arm64 expand-on-first-boot arm64 1.0 [2082 B]
2019-08-26 19:12:59 - INFO     - | Get:12 file:/isar-apt isar/main arm64 jailhouse-jailhouse arm64 0.11 [82.5 kB]
2019-08-26 19:12:59 - INFO     - | Get:17 file:/isar-apt isar/main arm64 non-root-initramfs arm64 2019.02.2 [1954 kB]
2019-08-26 19:12:59 - INFO     - | Get:18 file:/isar-apt isar/main arm64 sshd-regen-keys arm64 0.2 [1688 B]
2019-08-26 19:12:59 - INFO     - | Get:19 file:/isar-apt isar/main arm64 u-boot-tools arm64 2019.01-atf1.6 [93.1 kB]
2019-08-26 19:12:59 - INFO     - | Get:20 file:/isar-apt isar/main arm64 u-boot-script arm64 1.1 [2272 B]
2019-08-26 19:12:59 - INFO     - | Get:1 http://security-cdn.debian.org stretch/updates/main arm64 libexpat1 arm64 2.2.0-2+deb9u2 [72.2 kB]
2019-08-26 19:12:59 - INFO     - | Get:21 http://ftp.debian.org/debian stretch/main arm64 libcap2 arm64 1:2.25-1 [16.1 kB]
2019-08-26 19:12:59 - INFO     - | Get:22 http://ftp.debian.org/debian stretch/main arm64 dmsetup arm64 2:1.02.137-2 [100 kB]
2019-08-26 19:12:59 - INFO     - | Get:23 http://ftp.debian.org/debian stretch/main arm64 libdevmapper1.02.1 arm64 2:1.02.137-2 [143 kB]
2019-08-26 19:12:59 - INFO     - | Get:24 http://ftp.debian.org/debian stretch/main arm64 libcryptsetup4 arm64 2:1.7.3-4 [96.5 kB]
2019-08-26 19:12:59 - INFO     - | Get:25 http://ftp.debian.org/debian stretch/main arm64 libidn11 arm64 1.33-1 [112 kB]
2019-08-26 19:12:59 - INFO     - | Get:2 http://security-cdn.debian.org stretch/updates/main arm64 libssl1.1 arm64 1.1.0k-1~deb9u1 [1122 kB]
2019-08-26 19:12:59 - INFO     - | Get:26 http://ftp.debian.org/debian stretch/main arm64 libip4tc0 arm64 1.6.0+snapshot20161117-6 [66.4 kB]
2019-08-26 19:12:59 - INFO     - | Get:27 http://ftp.debian.org/debian stretch/main arm64 libkmod2 arm64 23-2 [40.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:28 http://ftp.debian.org/debian stretch/main arm64 libseccomp2 arm64 2.3.1-2.1+deb9u1 [36.2 kB]
2019-08-26 19:12:59 - INFO     - | Get:29 http://ftp.debian.org/debian stretch/main arm64 libncurses5 arm64 6.0+20161126-1+deb9u2 [75.4 kB]
2019-08-26 19:12:59 - INFO     - | Get:30 http://ftp.debian.org/debian stretch/main arm64 libprocps6 arm64 2:3.3.12-3+deb9u1 [54.8 kB]
2019-08-26 19:12:59 - INFO     - | Get:31 http://ftp.debian.org/debian stretch/main arm64 procps arm64 2:3.3.12-3+deb9u1 [235 kB]
2019-08-26 19:12:59 - INFO     - | Get:32 http://ftp.debian.org/debian stretch/main arm64 systemd arm64 232-25+deb9u11 [2142 kB]
2019-08-26 19:12:59 - INFO     - | Get:33 http://ftp.debian.org/debian stretch/main arm64 systemd-sysv arm64 232-25+deb9u11 [82.4 kB]
2019-08-26 19:12:59 - INFO     - | Get:34 http://ftp.debian.org/debian stretch/main arm64 init arm64 1.48 [12.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:3 http://security-cdn.debian.org stretch/updates/main arm64 libssl1.0.2 arm64 1.0.2s-1~deb9u1 [913 kB]
2019-08-26 19:12:59 - INFO     - | Get:35 http://ftp.debian.org/debian stretch/main arm64 udev arm64 232-25+deb9u11 [1057 kB]
2019-08-26 19:12:59 - INFO     - | Get:4 http://security-cdn.debian.org stretch/updates/main arm64 libisc-export160 arm64 1:9.10.3.dfsg.P4-12.3+deb9u5 [308 kB]
2019-08-26 19:12:59 - INFO     - | Get:5 http://security-cdn.debian.org stretch/updates/main arm64 libdns-export162 arm64 1:9.10.3.dfsg.P4-12.3+deb9u5 [721 kB]
2019-08-26 19:12:59 - INFO     - | Get:36 http://ftp.debian.org/debian stretch/main arm64 bash-completion all 1:2.1-4.3 [178 kB]
2019-08-26 19:12:59 - INFO     - | Get:6 http://security-cdn.debian.org stretch/updates/main arm64 xxd arm64 2:8.0.0197-4+deb9u3 [131 kB]
2019-08-26 19:12:59 - INFO     - | Get:8 http://security-cdn.debian.org stretch/updates/main arm64 vim-common all 2:8.0.0197-4+deb9u3 [159 kB]
2019-08-26 19:12:59 - INFO     - | Get:13 http://security-cdn.debian.org stretch/updates/main arm64 libdbus-1-3 arm64 1.10.28-0+deb9u1 [171 kB]
2019-08-26 19:12:59 - INFO     - | Get:37 http://ftp.debian.org/debian stretch/main arm64 groff-base arm64 1.22.3-9 [1158 kB]
2019-08-26 19:12:59 - INFO     - | Get:38 http://ftp.debian.org/debian stretch/main arm64 libbsd0 arm64 0.8.3-1 [77.8 kB]
2019-08-26 19:12:59 - INFO     - | Get:14 http://security-cdn.debian.org stretch/updates/main arm64 vim-runtime all 2:8.0.0197-4+deb9u3 [5409 kB]
2019-08-26 19:12:59 - INFO     - | Get:39 http://ftp.debian.org/debian stretch/main arm64 bsdmainutils arm64 9.0.12+nmu1 [182 kB]
2019-08-26 19:12:59 - INFO     - | Get:40 http://ftp.debian.org/debian stretch/main arm64 libgdbm3 arm64 1.8.3-14 [28.2 kB]
2019-08-26 19:12:59 - INFO     - | Get:41 http://ftp.debian.org/debian stretch/main arm64 libpipeline1 arm64 1.4.1-2 [25.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:42 http://ftp.debian.org/debian stretch/main arm64 man-db arm64 2.7.6.1-2 [1022 kB]
2019-08-26 19:12:59 - INFO     - | Get:43 http://ftp.debian.org/debian stretch/main arm64 libpython2.7-minimal arm64 2.7.13-2+deb9u3 [389 kB]
2019-08-26 19:12:59 - INFO     - | Get:44 http://ftp.debian.org/debian stretch/main arm64 python2.7-minimal arm64 2.7.13-2+deb9u3 [1213 kB]
2019-08-26 19:12:59 - INFO     - | Get:45 http://ftp.debian.org/debian stretch/main arm64 python-minimal arm64 2.7.13-2 [40.5 kB]
2019-08-26 19:12:59 - INFO     - | Get:46 http://ftp.debian.org/debian stretch/main arm64 mime-support all 3.60 [36.7 kB]
2019-08-26 19:12:59 - INFO     - | Get:47 http://ftp.debian.org/debian stretch/main arm64 libffi6 arm64 3.2.1-6 [19.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:48 http://ftp.debian.org/debian stretch/main arm64 readline-common all 7.0-3 [70.4 kB]
2019-08-26 19:12:59 - INFO     - | Get:49 http://ftp.debian.org/debian stretch/main arm64 libreadline7 arm64 7.0-3 [131 kB]
2019-08-26 19:12:59 - INFO     - | Get:50 http://ftp.debian.org/debian stretch/main arm64 libsqlite3-0 arm64 3.16.2-5+deb9u1 [495 kB]
2019-08-26 19:12:59 - INFO     - | Get:51 http://ftp.debian.org/debian stretch/main arm64 libpython2.7-stdlib arm64 2.7.13-2+deb9u3 [1832 kB]
2019-08-26 19:12:59 - INFO     - | Get:15 http://security-cdn.debian.org stretch/updates/main arm64 vim arm64 2:8.0.0197-4+deb9u3 [868 kB]
2019-08-26 19:12:59 - INFO     - | Get:52 http://ftp.debian.org/debian stretch/main arm64 python2.7 arm64 2.7.13-2+deb9u3 [285 kB]
2019-08-26 19:12:59 - INFO     - | Get:53 http://ftp.debian.org/debian stretch/main arm64 libpython-stdlib arm64 2.7.13-2 [20.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:54 http://ftp.debian.org/debian stretch/main arm64 python arm64 2.7.13-2 [154 kB]
2019-08-26 19:12:59 - INFO     - | Get:55 http://ftp.debian.org/debian stretch/main arm64 libedit2 arm64 3.1-20160903-3 [71.6 kB]
2019-08-26 19:12:59 - INFO     - | Get:56 http://ftp.debian.org/debian stretch/main arm64 libkeyutils1 arm64 1.5.9-9 [12.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:57 http://ftp.debian.org/debian stretch/main arm64 libkrb5support0 arm64 1.15-1+deb9u1 [58.8 kB]
2019-08-26 19:12:59 - INFO     - | Get:58 http://ftp.debian.org/debian stretch/main arm64 libk5crypto3 arm64 1.15-1+deb9u1 [111 kB]
2019-08-26 19:12:59 - INFO     - | Get:59 http://ftp.debian.org/debian stretch/main arm64 libkrb5-3 arm64 1.15-1+deb9u1 [268 kB]
2019-08-26 19:12:59 - INFO     - | Get:16 http://security-cdn.debian.org stretch/updates/main arm64 wpasupplicant arm64 2:2.4-1+deb9u4 [823 kB]
2019-08-26 19:12:59 - INFO     - | Get:60 http://ftp.debian.org/debian stretch/main arm64 libgssapi-krb5-2 arm64 1.15-1+deb9u1 [132 kB]
2019-08-26 19:12:59 - INFO     - | Get:61 http://ftp.debian.org/debian stretch/main arm64 openssh-client arm64 1:7.4p1-10+deb9u6 [699 kB]
2019-08-26 19:12:59 - INFO     - | Get:62 http://ftp.debian.org/debian stretch/main arm64 openssh-sftp-server arm64 1:7.4p1-10+deb9u6 [34.1 kB]
2019-08-26 19:12:59 - INFO     - | Get:63 http://ftp.debian.org/debian stretch/main arm64 ucf all 3.0036 [70.2 kB]
2019-08-26 19:12:59 - INFO     - | Get:64 http://ftp.debian.org/debian stretch/main arm64 libwrap0 arm64 7.6.q-26 [56.4 kB]
2019-08-26 19:12:59 - INFO     - | Get:65 http://ftp.debian.org/debian stretch/main arm64 openssh-server arm64 1:7.4p1-10+deb9u6 [289 kB]
2019-08-26 19:12:59 - INFO     - | Get:66 http://ftp.debian.org/debian stretch/main arm64 ssh all 1:7.4p1-10+deb9u6 [189 kB]
2019-08-26 19:12:59 - INFO     - | Get:67 http://ftp.debian.org/debian stretch/main arm64 libklibc arm64 2.0.4-9 [52.1 kB]
2019-08-26 19:12:59 - INFO     - | Get:68 http://ftp.debian.org/debian stretch/main arm64 klibc-utils arm64 2.0.4-9 [104 kB]
2019-08-26 19:12:59 - INFO     - | Get:69 http://ftp.debian.org/debian stretch/main arm64 cpio arm64 2.11+dfsg-6 [169 kB]
2019-08-26 19:12:59 - INFO     - | Get:70 http://ftp.debian.org/debian stretch/main arm64 kmod arm64 23-2 [74.2 kB]
2019-08-26 19:12:59 - INFO     - | Get:71 http://ftp.debian.org/debian stretch/main arm64 initramfs-tools-core all 0.130 [97.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:72 http://ftp.debian.org/debian stretch/main arm64 linux-base all 4.5 [19.1 kB]
2019-08-26 19:12:59 - INFO     - | Get:73 http://ftp.debian.org/debian stretch/main arm64 initramfs-tools all 0.130 [66.0 kB]
2019-08-26 19:12:59 - INFO     - | Get:74 http://ftp.debian.org/debian stretch/main arm64 libelf1 arm64 0.168-1 [150 kB]
2019-08-26 19:12:59 - INFO     - | Get:75 http://ftp.debian.org/debian stretch/main arm64 libmnl0 arm64 1.0.4-2 [11.3 kB]
2019-08-26 19:12:59 - INFO     - | Get:76 http://ftp.debian.org/debian stretch/main arm64 iproute2 arm64 4.9.0-1+deb9u1 [574 kB]
2019-08-26 19:12:59 - INFO     - | Get:77 http://ftp.debian.org/debian stretch/main arm64 ifupdown arm64 0.8.19 [72.7 kB]
2019-08-26 19:12:59 - INFO     - | Get:78 http://ftp.debian.org/debian stretch/main arm64 libnettle6 arm64 3.3-1+b2 [195 kB]
2019-08-26 19:12:59 - INFO     - | Get:79 http://ftp.debian.org/debian stretch/main arm64 iputils-ping arm64 3:20161105-1 [55.5 kB]
2019-08-26 19:12:59 - INFO     - | Get:80 http://ftp.debian.org/debian stretch/main arm64 isc-dhcp-client arm64 4.3.5-3+deb9u1 [295 kB]
2019-08-26 19:12:59 - INFO     - | Get:81 http://ftp.debian.org/debian stretch/main arm64 nano arm64 2.7.4-1 [474 kB]
2019-08-26 19:12:59 - INFO     - | Get:82 http://ftp.debian.org/debian stretch/main arm64 less arm64 481-2.1 [116 kB]
2019-08-26 19:12:59 - INFO     - | Get:83 http://ftp.debian.org/debian stretch/main arm64 libgpm2 arm64 1.20.4-6.2+b1 [33.3 kB]
2019-08-26 19:12:59 - INFO     - | Get:84 http://ftp.debian.org/debian stretch/main arm64 libpci3 arm64 1:3.5.2-1 [51.7 kB]
2019-08-26 19:12:59 - INFO     - | Get:85 http://ftp.debian.org/debian stretch/main arm64 pciutils arm64 1:3.5.2-1 [274 kB]
2019-08-26 19:12:59 - INFO     - | Get:86 http://ftp.debian.org/debian stretch/main arm64 ethtool arm64 1:4.8-1+b1 [102 kB]
2019-08-26 19:12:59 - INFO     - | Get:87 http://ftp.debian.org/debian stretch/non-free arm64 firmware-ti-connectivity all 20161130-5 [1011 kB]
2019-08-26 19:12:59 - INFO     - | Get:88 http://ftp.debian.org/debian stretch/main arm64 libiperf0 arm64 3.1.3-1 [51.8 kB]
2019-08-26 19:12:59 - INFO     - | Get:89 http://ftp.debian.org/debian stretch/main arm64 iperf3 arm64 3.1.3-1 [18.3 kB]
2019-08-26 19:12:59 - INFO     - | Get:90 http://ftp.debian.org/debian stretch/main arm64 libnl-3-200 arm64 3.2.27-2 [52.5 kB]
2019-08-26 19:12:59 - INFO     - | Get:91 http://ftp.debian.org/debian stretch/main arm64 libnl-genl-3-200 arm64 3.2.27-2 [19.5 kB]
2019-08-26 19:12:59 - INFO     - | Get:92 http://ftp.debian.org/debian stretch/main arm64 iw arm64 4.9-0.1 [62.8 kB]
2019-08-26 19:12:59 - INFO     - | Get:93 http://ftp.debian.org/debian stretch/main arm64 python-markupsafe arm64 0.23-3 [14.2 kB]
2019-08-26 19:12:59 - INFO     - | Get:94 http://ftp.debian.org/debian stretch/main arm64 python-mako all 1.0.6+ds1-2 [62.1 kB]
2019-08-26 19:12:59 - INFO     - | Get:95 http://ftp.debian.org/debian stretch/main arm64 libiw30 arm64 30~pre9-12+b1 [19.4 kB]
2019-08-26 19:12:59 - INFO     - | Get:96 http://ftp.debian.org/debian stretch/main arm64 libpcsclite1 arm64 1.8.20-1 [53.8 kB]
2019-08-26 19:12:59 - INFO     - | Get:97 http://ftp.debian.org/debian stretch/main arm64 libusb-1.0-0 arm64 2:1.0.21-1 [47.7 kB]
2019-08-26 19:12:59 - INFO     - | Get:98 http://ftp.debian.org/debian stretch/main arm64 net-tools arm64 1.60+git20161116.90da8a0-1 [236 kB]
2019-08-26 19:12:59 - INFO     - | Get:99 http://ftp.debian.org/debian stretch/main arm64 usbutils arm64 1:007-4+b1 [211 kB]
2019-08-26 19:12:59 - INFO     - | Get:100 http://ftp.debian.org/debian stretch/main arm64 wireless-tools arm64 30~pre9-12+b1 [110 kB]
2019-08-26 19:12:59 - INFO     - | Fetched 29.3 MB in 18s (1598 kB/s)
2019-08-26 19:12:59 - INFO     - | Download complete and in download only mode
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function rootfs_install_pkgs_download finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function image_install_localepurge_download
2019-08-26 19:12:59 - INFO     - | Reading package lists...
2019-08-26 19:12:59 - INFO     - | Building dependency tree...
2019-08-26 19:12:59 - INFO     - | Reading state information...
2019-08-26 19:12:59 - INFO     - | Starting pkgProblemResolver with broken count: 0
2019-08-26 19:12:59 - INFO     - | Starting 2 pkgProblemResolver with broken count: 0
2019-08-26 19:12:59 - INFO     - | Done
2019-08-26 19:12:59 - INFO     - | The following additional packages will be installed:
2019-08-26 19:12:59 - INFO     - |   libncurses5 libprocps6 procps ucf
2019-08-26 19:12:59 - INFO     - | Suggested packages:
2019-08-26 19:12:59 - INFO     - |   debfoster deborphan bleachbit
2019-08-26 19:12:59 - INFO     - | Recommended packages:
2019-08-26 19:12:59 - INFO     - |   libgpm2 psmisc
2019-08-26 19:12:59 - INFO     - | The following NEW packages will be installed:
2019-08-26 19:12:59 - INFO     - |   libncurses5 libprocps6 localepurge procps ucf
2019-08-26 19:12:59 - INFO     - | 0 upgraded, 5 newly installed, 0 to remove and 0 not upgraded.
2019-08-26 19:12:59 - INFO     - | Need to get 52.4 kB/487 kB of archives.
2019-08-26 19:12:59 - INFO     - | After this operation, 1353 kB of additional disk space will be used.
2019-08-26 19:12:59 - INFO     - | Get:1 http://ftp.debian.org/debian stretch/main arm64 localepurge all 0.7.3.4 [52.4 kB]
2019-08-26 19:12:59 - INFO     - | Fetched 52.4 kB in 0s (308 kB/s)
2019-08-26 19:12:59 - INFO     - | Download complete and in download only mode
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function image_install_localepurge_download finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_install_clean_files
2019-08-26 19:12:59 - INFO     - | DEBUG: Shell function rootfs_install_clean_files finished
2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_install_pkgs_install
2019-08-26 19:12:59 - INFO     - | Reading package lists...
2019-08-26 19:12:59 - INFO     - | Building dependency tree...
2019-08-26 19:12:59 - INFO     - | Reading state information...
2019-08-26 19:12:59 - INFO     - | Starting pkgProblemResolver with broken count: 0
2019-08-26 19:12:59 - INFO     - | Starting 2 pkgProblemResolver with broken count: 0
2019-08-26 19:12:59 - INFO     - | Done
2019-08-26 19:12:59 - INFO     - | The following additional packages will be installed:
2019-08-26 19:12:59 - INFO     - |   bsdmainutils cpio dmsetup groff-base initramfs-tools initramfs-tools-core
2019-08-26 19:12:59 - INFO     - |   iproute2 klibc-utils kmod libapparmor1 libbsd0 libcap2 libcryptsetup4
2019-08-26 19:12:59 - INFO     - |   libdbus-1-3 libdevmapper1.02.1 libdns-export162 libedit2 libelf1 libexpat1
2019-08-26 19:12:59 - INFO     - |   libffi6 libgdbm3 libgpm2 libgssapi-krb5-2 libidn11 libip4tc0 libiperf0
2019-08-26 19:12:59 - INFO     - |   libisc-export160 libiw30 libk5crypto3 libkeyutils1 libklibc libkmod2
2019-08-26 19:12:59 - INFO     - |   libkrb5-3 libkrb5support0 libmnl0 libncurses5 libnettle6 libnl-3-200
2019-08-26 19:12:59 - INFO     - |   libnl-genl-3-200 libpci3 libpcsclite1 libpipeline1 libprocps6
2019-08-26 19:12:59 - INFO     - |   libpython-stdlib libpython2.7-minimal libpython2.7-stdlib libreadline7
2019-08-26 19:12:59 - INFO     - |   libseccomp2 libsqlite3-0 libssl1.0.2 libssl1.1 libusb-1.0-0 libwrap0
2019-08-26 19:12:59 - INFO     - |   linux-base mime-support openssh-client openssh-server openssh-sftp-server
2019-08-26 19:12:59 - INFO     - |   procps python python-mako python-markupsafe python-minimal python2.7
2019-08-26 19:12:59 - INFO     - |   python2.7-minimal readline-common systemd systemd-sysv u-boot-tools ucf udev
2019-08-26 19:12:59 - INFO     - |   vim-common vim-runtime xxd
2019-08-26 19:12:59 - INFO     - | Suggested packages:
2019-08-26 19:12:59 - INFO     - |   cpp wamerican | wordlist whois vacation libarchive1 groff ppp rdnssd
2019-08-26 19:12:59 - INFO     - |   iproute2-doc resolvconf avahi-autoipd isc-dhcp-client-ddns gpm krb5-doc
2019-08-26 19:12:59 - INFO     - |   krb5-user pcscd www-browser spell keychain libpam-ssh monkeysphere
2019-08-26 19:12:59 - INFO     - |   ssh-askpass molly-guard rssh ufw bzip2 wget | curl | lynx-cur python-doc
2019-08-26 19:12:59 - INFO     - |   python-tk python-beaker python-mako-doc python2.7-doc binutils
2019-08-26 19:12:59 - INFO     - |   binfmt-support readline-doc systemd-ui systemd-container policykit-1 wget
2019-08-26 19:12:59 - INFO     - |   | lynx-cur ctags vim-doc vim-scripts wpagui libengine-pkcs11-openssl
2019-08-26 19:12:59 - INFO     - | Recommended packages:
2019-08-26 19:12:59 - INFO     - |   busybox | busybox-static libatm1 libxtables12 libcap2-bin isc-dhcp-common
2019-08-26 19:12:59 - INFO     - |   crda dbus krb5-locales tcpd bzip2 file xz-utils xauth libpam-systemd
2019-08-26 19:12:59 - INFO     - |   ncurses-term psmisc
2019-08-26 19:12:59 - INFO     - | The following NEW packages will be installed:
2019-08-26 19:12:59 - INFO     - |   bash-completion bsdmainutils cpio customizations-ultra96 dmsetup ethtool
2019-08-26 19:12:59 - INFO     - |   expand-on-first-boot firmware-ti-connectivity groff-base ifupdown init
2019-08-26 19:12:59 - INFO     - |   initramfs-tools initramfs-tools-core iperf3 iproute2 iputils-ping
2019-08-26 19:12:59 - INFO     - |   isc-dhcp-client iw jailhouse-jailhouse klibc-utils kmod less libapparmor1
2019-08-26 19:12:59 - INFO     - |   libbsd0 libcap2 libcryptsetup4 libdbus-1-3 libdevmapper1.02.1
2019-08-26 19:12:59 - INFO     - |   libdns-export162 libedit2 libelf1 libexpat1 libffi6 libgdbm3 libgpm2
2019-08-26 19:12:59 - INFO     - |   libgssapi-krb5-2 libidn11 libip4tc0 libiperf0 libisc-export160 libiw30
2019-08-26 19:12:59 - INFO     - |   libk5crypto3 libkeyutils1 libklibc libkmod2 libkrb5-3 libkrb5support0
2019-08-26 19:12:59 - INFO     - |   libmnl0 libncurses5 libnettle6 libnl-3-200 libnl-genl-3-200 libpci3
2019-08-26 19:12:59 - INFO     - |   libpcsclite1 libpipeline1 libprocps6 libpython-stdlib libpython2.7-minimal
2019-08-26 19:12:59 - INFO     - |   libpython2.7-stdlib libreadline7 libseccomp2 libsqlite3-0 libssl1.0.2
2019-08-26 19:12:59 - INFO     - |   libssl1.1 libusb-1.0-0 libwrap0 linux-base linux-image-jailhouse man-db
2019-08-26 19:12:59 - INFO     - |   mime-support nano net-tools non-root-initramfs openssh-client openssh-server
2019-08-26 19:12:59 - INFO     - |   openssh-sftp-server pciutils procps python python-mako python-markupsafe
2019-08-26 19:12:59 - INFO     - |   python-minimal python2.7 python2.7-minimal readline-common ssh
2019-08-26 19:12:59 - INFO     - |   sshd-regen-keys systemd systemd-sysv u-boot-script u-boot-tools ucf udev
2019-08-26 19:12:59 - INFO     - |   usbutils vim vim-common vim-runtime wireless-tools wpasupplicant xxd
2019-08-26 19:12:59 - INFO     - | 0 upgraded, 100 newly installed, 0 to remove and 0 not upgraded.
2019-08-26 19:12:59 - INFO     - | Need to get 0 B/39.3 MB of archives.
2019-08-26 19:12:59 - INFO     - | After this operation, 147 MB of additional disk space will be used.
2019-08-26 19:12:59 - INFO     - | Get:1 file:/isar-apt isar/main arm64 linux-image-jailhouse arm64 4.19.67-1 [7802 kB]
2019-08-26 19:12:59 - INFO     - | Get:2 file:/isar-apt isar/main arm64 customizations-ultra96 arm64 1.0 [2914 B]
2019-08-26 19:12:59 - INFO     - | Get:3 file:/isar-apt isar/main arm64 expand-on-first-boot arm64 1.0 [2082 B]
2019-08-26 19:12:59 - INFO     - | Get:4 file:/isar-apt isar/main arm64 jailhouse-jailhouse arm64 0.11 [82.5 kB]
2019-08-26 19:12:59 - INFO     - | Get:5 file:/isar-apt isar/main arm64 non-root-initramfs arm64 2019.02.2 [1954 kB]
2019-08-26 19:12:59 - INFO     - | Get:6 file:/isar-apt isar/main arm64 sshd-regen-keys arm64 0.2 [1688 B]
2019-08-26 19:12:59 - INFO     - | Get:7 file:/isar-apt isar/main arm64 u-boot-tools arm64 2019.01-atf1.6 [93.1 kB]
2019-08-26 19:12:59 - INFO     - | Get:8 file:/isar-apt isar/main arm64 u-boot-script arm64 1.1 [2272 B]
2019-08-26 19:12:59 - INFO     - | debconf: delaying package configuration, since apt-utils is not installed
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libapparmor1:arm64.
2019-08-26 19:12:59 - INFO     - | (Reading database ...
2019-08-26 19:12:59 - INFO     - | (Reading database ... 5%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 10%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 15%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 20%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 25%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 30%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 35%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 40%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 45%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 50%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 55%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 60%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 65%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 70%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 75%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 80%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 85%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 90%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 95%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 100%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 6945 files and directories currently installed.)
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../00-libapparmor1_2.11.0-3+deb9u2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libapparmor1:arm64 (2.11.0-3+deb9u2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libcap2:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../01-libcap2_1%3a2.25-1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libcap2:arm64 (1:2.25-1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package dmsetup.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../02-dmsetup_2%3a1.02.137-2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking dmsetup (2:1.02.137-2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libdevmapper1.02.1:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../03-libdevmapper1.02.1_2%3a1.02.137-2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libdevmapper1.02.1:arm64 (2:1.02.137-2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libcryptsetup4:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../04-libcryptsetup4_2%3a1.7.3-4_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libcryptsetup4:arm64 (2:1.7.3-4) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libidn11:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../05-libidn11_1.33-1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libidn11:arm64 (1.33-1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libip4tc0:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../06-libip4tc0_1.6.0+snapshot20161117-6_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libip4tc0:arm64 (1.6.0+snapshot20161117-6) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libkmod2:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../07-libkmod2_23-2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libkmod2:arm64 (23-2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libseccomp2:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../08-libseccomp2_2.3.1-2.1+deb9u1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libseccomp2:arm64 (2.3.1-2.1+deb9u1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libncurses5:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../09-libncurses5_6.0+20161126-1+deb9u2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libncurses5:arm64 (6.0+20161126-1+deb9u2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libprocps6:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../10-libprocps6_2%3a3.3.12-3+deb9u1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libprocps6:arm64 (2:3.3.12-3+deb9u1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package procps.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../11-procps_2%3a3.3.12-3+deb9u1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking procps (2:3.3.12-3+deb9u1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package systemd.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../12-systemd_232-25+deb9u11_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking systemd (232-25+deb9u11) ...
2019-08-26 19:12:59 - INFO     - | Setting up libapparmor1:arm64 (2.11.0-3+deb9u2) ...
2019-08-26 19:12:59 - INFO     - | Setting up libcap2:arm64 (1:2.25-1) ...
2019-08-26 19:12:59 - INFO     - | Setting up libidn11:arm64 (1.33-1) ...
2019-08-26 19:12:59 - INFO     - | Setting up libip4tc0:arm64 (1.6.0+snapshot20161117-6) ...
2019-08-26 19:12:59 - INFO     - | Setting up libkmod2:arm64 (23-2) ...
2019-08-26 19:12:59 - INFO     - | Setting up libseccomp2:arm64 (2.3.1-2.1+deb9u1) ...
2019-08-26 19:12:59 - INFO     - | Setting up libncurses5:arm64 (6.0+20161126-1+deb9u2) ...
2019-08-26 19:12:59 - INFO     - | Setting up libprocps6:arm64 (2:3.3.12-3+deb9u1) ...
2019-08-26 19:12:59 - INFO     - | Setting up procps (2:3.3.12-3+deb9u1) ...
2019-08-26 19:12:59 - INFO     - | update-alternatives: using /usr/bin/w.procps to provide /usr/bin/w (w) in auto mode
2019-08-26 19:12:59 - INFO     - | Setting up libdevmapper1.02.1:arm64 (2:1.02.137-2) ...
2019-08-26 19:12:59 - INFO     - | Setting up libcryptsetup4:arm64 (2:1.7.3-4) ...
2019-08-26 19:12:59 - INFO     - | Setting up systemd (232-25+deb9u11) ...
2019-08-26 19:12:59 - INFO     - | Created symlink /etc/systemd/system/getty.target.wants/getty@tty1.service -> /lib/systemd/system/getty@.service.
2019-08-26 19:12:59 - INFO     - | Created symlink /etc/systemd/system/multi-user.target.wants/remote-fs.target -> /lib/systemd/system/remote-fs.target.
2019-08-26 19:12:59 - INFO     - | Created symlink /etc/systemd/system/sysinit.target.wants/systemd-timesyncd.service -> /lib/systemd/system/systemd-timesyncd.service.
2019-08-26 19:12:59 - INFO     - | Initializing machine ID from random generator.
2019-08-26 19:12:59 - INFO     - | Adding group `systemd-journal' (GID 101) ...
2019-08-26 19:12:59 - INFO     - | Done.
2019-08-26 19:12:59 - INFO     - | Setting up dmsetup (2:1.02.137-2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package systemd-sysv.
2019-08-26 19:12:59 - INFO     - | (Reading database ...
2019-08-26 19:12:59 - INFO     - | (Reading database ... 5%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 10%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 15%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 20%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 25%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 30%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 35%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 40%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 45%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 50%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 55%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 60%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 65%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 70%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 75%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 80%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 85%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 90%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 95%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 100%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 7768 files and directories currently installed.)
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../systemd-sysv_232-25+deb9u11_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking systemd-sysv (232-25+deb9u11) ...
2019-08-26 19:12:59 - INFO     - | Setting up systemd-sysv (232-25+deb9u11) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package init.
2019-08-26 19:12:59 - INFO     - | (Reading database ...
2019-08-26 19:12:59 - INFO     - | (Reading database ... 5%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 10%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 15%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 20%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 25%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 30%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 35%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 40%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 45%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 50%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 55%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 60%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 65%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 70%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 75%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 80%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 85%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 90%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 95%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 100%
2019-08-26 19:12:59 - INFO     - | (Reading database ... 7785 files and directories currently installed.)
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../00-init_1.48_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking init (1.48) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package udev.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../01-udev_232-25+deb9u11_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking udev (232-25+deb9u11) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package bash-completion.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../02-bash-completion_1%3a2.1-4.3_all.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking bash-completion (1:2.1-4.3) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package groff-base.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../03-groff-base_1.22.3-9_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking groff-base (1.22.3-9) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libbsd0:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../04-libbsd0_0.8.3-1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libbsd0:arm64 (0.8.3-1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package bsdmainutils.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../05-bsdmainutils_9.0.12+nmu1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking bsdmainutils (9.0.12+nmu1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libgdbm3:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../06-libgdbm3_1.8.3-14_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libgdbm3:arm64 (1.8.3-14) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libpipeline1:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../07-libpipeline1_1.4.1-2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libpipeline1:arm64 (1.4.1-2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package man-db.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../08-man-db_2.7.6.1-2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking man-db (2.7.6.1-2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libpython2.7-minimal:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../09-libpython2.7-minimal_2.7.13-2+deb9u3_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libpython2.7-minimal:arm64 (2.7.13-2+deb9u3) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package python2.7-minimal.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../10-python2.7-minimal_2.7.13-2+deb9u3_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking python2.7-minimal (2.7.13-2+deb9u3) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package python-minimal.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../11-python-minimal_2.7.13-2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking python-minimal (2.7.13-2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package mime-support.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../12-mime-support_3.60_all.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking mime-support (3.60) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libexpat1:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../13-libexpat1_2.2.0-2+deb9u2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libexpat1:arm64 (2.2.0-2+deb9u2) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libffi6:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../14-libffi6_3.2.1-6_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libffi6:arm64 (3.2.1-6) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package readline-common.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../15-readline-common_7.0-3_all.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking readline-common (7.0-3) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libreadline7:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../16-libreadline7_7.0-3_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libreadline7:arm64 (7.0-3) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libsqlite3-0:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../17-libsqlite3-0_3.16.2-5+deb9u1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libsqlite3-0:arm64 (3.16.2-5+deb9u1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libssl1.1:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../18-libssl1.1_1.1.0k-1~deb9u1_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libssl1.1:arm64 (1.1.0k-1~deb9u1) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libpython2.7-stdlib:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../19-libpython2.7-stdlib_2.7.13-2+deb9u3_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libpython2.7-stdlib:arm64 (2.7.13-2+deb9u3) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package python2.7.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../20-python2.7_2.7.13-2+deb9u3_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking python2.7 (2.7.13-2+deb9u3) ...
2019-08-26 19:12:59 - INFO     - | Selecting previously unselected package libpython-stdlib:arm64.
2019-08-26 19:12:59 - INFO     - | Preparing to unpack .../21-libpython-stdlib_2.7.13-2_arm64.deb ...
2019-08-26 19:12:59 - INFO     - | Unpacking libpython-stdlib:arm64 (2.7.13-2) ...
2019-08-26 19:12:59 - INFO     - | Setting up libpython2.7-minimal:arm64 (2.7.13-2+deb9u3) ...
2019-08-26 19:12:59 - INFO     - | Setting up python2.7-minimal (2.7.13-2+deb9u3) ...
2019-08-26 19:12:59 - INFO     - | Setting up python-minimal (2.7.13-2) ...
2019-08-26 19:12:59 - INFO     - | dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install-iVLVJB/57-u-boot-tools_2019.01-atf1.6_arm64.deb': No such file or directory
2019-08-26 19:12:59 - INFO     - | E: Sub-process /usr/bin/dpkg returned an error code (2)
2019-08-26 19:12:59 - INFO     - | WARNING: exit code 100 from a shell command.
2019-08-26 19:12:59 - INFO     - | DEBUG: Python function do_rootfs_install finished
2019-08-26 19:12:59 - INFO     - | ERROR: Function failed: rootfs_install_pkgs_install (log file is located at /builds/ebsy/debian/build/tmp/work/jailhouse-demo-arm64/demo-image-ultra96-wic-img/1.0-r0/temp/log.do_rootfs_install.60341)
2019-08-26 19:12:59 - INFO     - NOTE: recipe demo-image-1.0-r0: task do_rootfs_install: Failed
2019-08-26 19:12:59 - INFO     - NOTE: Running task 787 of 864 (multiconfig:ultra96-jailhouse-demo:/builds/ebsy/debian/jailhouse-images/recipes-core/images/demo-image.bb:do_install_imager_deps)
2019-08-26 19:12:59 - ERROR    - ERROR: Task (multiconfig:ultra96-jailhouse-demo:/builds/ebsy/debian/jailhouse-images/recipes-core/images/demo-image.bb:do_rootfs_install) failed with exit code '1'

-- 
Siemens AG, Corporate Technology, CT RDA IOT SES-DE
Corporate Competence Center Embedded Linux

^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install...
  2019-08-26 20:22 dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install Jan Kiszka
@ 2019-08-26 20:59 ` Baurzhan Ismagulov
       [not found]   ` <136f3300-8dc3-5f42-13fc-4c04414f7801@siemens.com>
  0 siblings, 1 reply; 4+ messages in thread
From: Baurzhan Ismagulov @ 2019-08-26 20:59 UTC (permalink / raw)
  To: isar-users

On Mon, Aug 26, 2019 at 10:22:21PM +0200, Jan Kiszka wrote:
> 2019-08-26 19:12:59 - ERROR    - ERROR: mc:ultra96-jailhouse-demo:demo-image-1.0-r0 do_rootfs_install: Function failed: rootfs_install_pkgs_install (log file is located at /builds/ebsy/debian/build/tmp/work/jailhouse-demo-arm64/demo-image-ultra96-wic-img/1.0-r0/temp/log.do_rootfs_install.60341)
> [...]
> 2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function rootfs_install_pkgs_install
> [...]
> 2019-08-26 19:12:59 - INFO     - | Get:7 file:/isar-apt isar/main arm64 u-boot-tools arm64 2019.01-atf1.6 [93.1 kB]
> [...]
> 2019-08-26 19:12:59 - INFO     - | Setting up python-minimal (2.7.13-2) ...
> 2019-08-26 19:12:59 - INFO     - | dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install-iVLVJB/57-u-boot-tools_2019.01-atf1.6_arm64.deb': No such file or directory
> 2019-08-26 19:12:59 - INFO     - | E: Sub-process /usr/bin/dpkg returned an error code (2)

Wow, I remember having seen this task failing in the past, but not such
straight ENOENT. Is this reproducible?

With kind regards,
Baurzhan.

^ permalink raw reply	[flat|nested] 4+ messages in thread

[parent not found: <136f3300-8dc3-5f42-13fc-4c04414f7801@siemens.com>]

* isar-apt locking: install_imager_deps vs rootfs_install (was: Re: dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install...)
       [not found]   ` <136f3300-8dc3-5f42-13fc-4c04414f7801@siemens.com>
@ 2019-09-02  8:08     ` Jan Kiszka
  2019-09-18 13:39       ` Baurzhan Ismagulov
  0 siblings, 1 reply; 4+ messages in thread
From: Jan Kiszka @ 2019-09-02  8:08 UTC (permalink / raw)
  To: isar-users; +Cc: Baurzhan Ismagulov, Cedric Hombourger

On 26.08.19 23:28, Jan Kiszka wrote:
> On 26.08.19 22:59, Baurzhan Ismagulov wrote:
>> On Mon, Aug 26, 2019 at 10:22:21PM +0200, Jan Kiszka wrote:
>>> 2019-08-26 19:12:59 - ERROR    - ERROR: 
>>> mc:ultra96-jailhouse-demo:demo-image-1.0-r0 do_rootfs_install: Function 
>>> failed: rootfs_install_pkgs_install (log file is located at 
>>> /builds/ebsy/debian/build/tmp/work/jailhouse-demo-arm64/demo-image-ultra96-wic-img/1.0-r0/temp/log.do_rootfs_install.60341) 
>>>
>>> [...]
>>> 2019-08-26 19:12:59 - INFO     - | DEBUG: Executing shell function 
>>> rootfs_install_pkgs_install
>>> [...]
>>> 2019-08-26 19:12:59 - INFO     - | Get:7 file:/isar-apt isar/main arm64 
>>> u-boot-tools arm64 2019.01-atf1.6 [93.1 kB]
>>> [...]
>>> 2019-08-26 19:12:59 - INFO     - | Setting up python-minimal (2.7.13-2) ...
>>> 2019-08-26 19:12:59 - INFO     - | dpkg: error: cannot stat pathname 
>>> '/tmp/apt-dpkg-install-iVLVJB/57-u-boot-tools_2019.01-atf1.6_arm64.deb': No 
>>> such file or directory
>>> 2019-08-26 19:12:59 - INFO     - | E: Sub-process /usr/bin/dpkg returned an 
>>> error code (2)
>>
>> Wow, I remember having seen this task failing in the past, but not such
>> straight ENOENT. Is this reproducible?
> 
> Only by chance, and only on our CI server so far. That's likely qualifies as "no".
> 

Just had this two times in a row now, so I dug deeper: The failure was 
always around self-built u-boot-tools and two images pulling that in 
more or less in parallel to a third one generating that package once 
again. All are sharing the same u-boot version for custom builds, thus 
u-boot-tools gets deployed multiple times.

Looking at our locking around isar-apt I noticed that we hold the lock 
for install_imager_deps, but we do not for rootfs_install. Why should 
both be different? I played with a shared isar-apt lock around 
rootfs_install, to avoid massive serialization, and that didn't make the 
issue show up again, so far. But does it make sense?

diff --git a/meta/classes/rootfs.bbclass b/meta/classes/rootfs.bbclass
index c7e0435..5ef66ee 100644
--- a/meta/classes/rootfs.bbclass
+++ b/meta/classes/rootfs.bbclass
@@ -135,6 +135,9 @@ do_rootfs_install[vardeps] = "${ROOTFS_CONFIGURE_COMMAND} ${ROOTFS_INSTALL_COMMA
 do_rootfs_install[depends] = "isar-bootstrap-${@'target' if d.getVar('ROOTFS_ARCH') == d.getVar('DISTRO_ARCH') else 'host'}:do_build isar-apt:do_cache_config"
 do_rootfs_install[deptask] = "do_deploy_deb"
 python do_rootfs_install() {
+    lock = bb.utils.lockfile(d.getVar("REPO_ISAR_DIR") + "/isar.lock",
+                             shared=True)
+
     configure_cmds = (d.getVar("ROOTFS_CONFIGURE_COMMAND", True) or "").split()
     install_cmds = (d.getVar("ROOTFS_INSTALL_COMMAND", True) or "").split()
 
@@ -155,6 +158,8 @@ python do_rootfs_install() {
         progress_reporter.next_stage()
         bb.build.exec_func(cmd, d)
     progress_reporter.finish()
+
+    bb.utils.unlockfile(lock)
 }
 addtask rootfs_install before do_rootfs_postprocess after do_unpack
 

The other issue is that u-boot-tools can get built and deployed multiple 
times if multiple custom u-boots are generated. That may even lead to 
underministic results when the builds use different u-boot sources. I 
will add some control to the recipe to select which one shall deploy the 
tools in case there are multiple options. I suspect we will see similar 
issues when the kernel starts building tools...

Jan

-- 
Siemens AG, Corporate Technology, CT RDA IOT SES-DE
Corporate Competence Center Embedded Linux

^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: isar-apt locking: install_imager_deps vs rootfs_install (was: Re: dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install...)
  2019-09-02  8:08     ` isar-apt locking: install_imager_deps vs rootfs_install (was: Re: dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install...) Jan Kiszka
@ 2019-09-18 13:39       ` Baurzhan Ismagulov
  0 siblings, 0 replies; 4+ messages in thread
From: Baurzhan Ismagulov @ 2019-09-18 13:39 UTC (permalink / raw)
  To: isar-users

On Mon, Sep 02, 2019 at 10:08:38AM +0200, Jan Kiszka wrote:
> Just had this two times in a row now, so I dug deeper: The failure was 
> always around self-built u-boot-tools and two images pulling that in 
> more or less in parallel to a third one generating that package once 
> again. All are sharing the same u-boot version for custom builds, thus 
> u-boot-tools gets deployed multiple times.
> 
> Looking at our locking around isar-apt I noticed that we hold the lock 
> for install_imager_deps, but we do not for rootfs_install. Why should 
> both be different? I played with a shared isar-apt lock around 
> rootfs_install, to avoid massive serialization, and that didn't make the 
> issue show up again, so far. But does it make sense?

I think it does.

With kind regards,
Baurzhan.

^ permalink raw reply	[flat|nested] 4+ messages in thread

end of thread, other threads:[~2019-09-18 13:39 UTC | newest]

Thread overview: 4+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2019-08-26 20:22 dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install Jan Kiszka
2019-08-26 20:59 ` Baurzhan Ismagulov
     [not found]   ` <136f3300-8dc3-5f42-13fc-4c04414f7801@siemens.com>
2019-09-02  8:08     ` isar-apt locking: install_imager_deps vs rootfs_install (was: Re: dpkg: error: cannot stat pathname '/tmp/apt-dpkg-install...) Jan Kiszka
2019-09-18 13:39       ` Baurzhan Ismagulov

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox