Attachment 1580398 Details for Bug 1720381 – Excerpt of /var/log/dnf.librepo.log for problematic dnf call

Excerpt of /var/log/dnf.librepo.log for problematic dnf call

dnf.librepo.log (text/plain), 14.04 KB, created by Uwe Menges on 2019-06-13 21:16:29 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Uwe Menges

Created: 2019-06-13 21:16:29 UTC

Size: 14.04 KB

patch

obsolete

>2019-06-13T21:09:05Z DEBUG Librepo version: 1.9.6 with CURL_GLOBAL_ACK_EINTR support (libcurl/7.61.1 OpenSSL/1.1.1b zlib/1.2.11 brotli/1.0.5 libidn2/2.2.0 libpsl/0.20.2 (+libidn2/2.0.5) libssh/0.8.7/openssl/zlib nghttp2/1.34.0)
>2019-06-13T21:09:05Z DEBUG Current date: 2019-06-13T23:09:05+0200
>2019-06-13T21:09:05Z DEBUG Librepo version: 1.9.6 with CURL_GLOBAL_ACK_EINTR support (libcurl/7.61.1 OpenSSL/1.1.1b zlib/1.2.11 brotli/1.0.5 libidn2/2.2.0 libpsl/0.20.2 (+libidn2/2.0.5) libssh/0.8.7/openssl/zlib nghttp2/1.34.0)
>2019-06-13T21:09:05Z DEBUG Current date: 2019-06-13T23:09:05+0200
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using dir: /var/cache/dnf/fedora-modular-d5aeb8fa01df740a
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using own SIGINT handler
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Preparing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing mirrors reported via LRI_MIRRORS
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Downloading/Locating yum repo
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local: Locating repo..
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local_load_base: Parsing repomd.xml
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local_load_base: Repomd revision: 1540419659
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local: Repository was successfully located
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checking checksum of /var/cache/dnf/fedora-modular-d5aeb8fa01df740a/repodata/6e103cbb21f99c2140345730236cc64b7b0f329c6e50a087b1f0d8979a022637-primary.xml.gz (expected: 6e103cbb21f99c2140345730236cc64b7b0f329c6e50a087b1f0d8979a022637 [sha256])
>2019-06-13T21:09:05Z DEBUG lr_checksum_fd_compare: Using checksum cached in xattr: [user.Zif.MdChecksum[1560459404]] 6e103cbb21f99c2140345730236cc64b7b0f329c6e50a087b1f0d8979a022637
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checksum check - Passed
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checking checksum of /var/cache/dnf/fedora-modular-d5aeb8fa01df740a/repodata/08c1805a463a6ca2b672d737d0208a84a28f65b9b56197364ad3ff93720eb2b0-filelists.xml.gz (expected: 08c1805a463a6ca2b672d737d0208a84a28f65b9b56197364ad3ff93720eb2b0 [sha256])
>2019-06-13T21:09:05Z DEBUG lr_checksum_fd_compare: Using checksum cached in xattr: [user.Zif.MdChecksum[1559407126]] 08c1805a463a6ca2b672d737d0208a84a28f65b9b56197364ad3ff93720eb2b0
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checksum check - Passed
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checking checksum of /var/cache/dnf/fedora-modular-d5aeb8fa01df740a/repodata/f9c79f57df3635d56bd4887706c10e95ec89f87bf14bb17501186123fb5efaf6-comps-Modular.x86_64.xml.xz (expected: f9c79f57df3635d56bd4887706c10e95ec89f87bf14bb17501186123fb5efaf6 [sha256])
>2019-06-13T21:09:05Z DEBUG lr_checksum_fd_compare: Using checksum cached in xattr: [user.Zif.MdChecksum[1559407126]] f9c79f57df3635d56bd4887706c10e95ec89f87bf14bb17501186123fb5efaf6
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checksum check - Passed
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checking checksum of /var/cache/dnf/fedora-modular-d5aeb8fa01df740a/repodata/256554a6d4e29b3ab128655ad4e72932765cc7e2da3192199efd11ae2cb7cf7a-modules.yaml.gz (expected: 256554a6d4e29b3ab128655ad4e72932765cc7e2da3192199efd11ae2cb7cf7a [sha256])
>2019-06-13T21:09:05Z DEBUG lr_checksum_fd_compare: Using checksum cached in xattr: [user.Zif.MdChecksum[1559407126]] 256554a6d4e29b3ab128655ad4e72932765cc7e2da3192199efd11ae2cb7cf7a
>2019-06-13T21:09:05Z DEBUG lr_yum_check_checksum_of_md_record: Checksum check - Passed
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Restoring an old SIGINT handler
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using dir: /tmp/tmpdir.yM0Ag5
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using own SIGINT handler
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Preparing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing mirrors reported via LRI_MIRRORS
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Downloading/Locating yum repo
>2019-06-13T21:09:05Z DEBUG lr_yum_download_remote: Downloading/Copying repo..
>2019-06-13T21:09:05Z DEBUG lr_yum_download_repomd: Downloading repomd.xml via mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_download: Target: repodata/repomd.xml (-)
>2019-06-13T21:09:05Z DEBUG lr_prepare_lrmirrors: Preparing internal mirror list for handle id: 0x560542e95f80
>2019-06-13T21:09:05Z DEBUG lr_prepare_lrmirrors: Mirror: http://download.fedoraproject.org/pub/fedora/linux/releases/29/Modular/x86_64/os/
>2019-06-13T21:09:05Z DEBUG select_next_target: Selecting mirror for: repodata/repomd.xml
>2019-06-13T21:09:05Z DEBUG prepare_next_transfer: URL: http://download.fedoraproject.org/pub/fedora/linux/releases/29/Modular/x86_64/os/repodata/repomd.xml
>2019-06-13T21:09:05Z DEBUG add_librepo_xattr: Cannot set xattr user.Librepo.DownloadInProgress (fd: 8): Operation not supported
>2019-06-13T21:09:05Z DEBUG lr_download: Downloading started
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Transfer finished: repodata/repomd.xml (Effective url: http://download.fedoraproject.org/pub/fedora/linux/releases/29/Modular/x86_64/os/repodata/repomd.xml)
>2019-06-13T21:09:05Z DEBUG lr_yum_download_remote: Parsing repomd.xml
>2019-06-13T21:09:05Z DEBUG 1540419659: Repomd revision: lr_yum_download_remote
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Restoring an old SIGINT handler
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using dir: /var/cache/dnf/updates-modular-4aefdcf1392b839d
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using own SIGINT handler
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Preparing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing mirrors reported via LRI_MIRRORS
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Downloading/Locating yum repo
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local: Locating repo..
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local_load_base: Parsing repomd.xml
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local_load_base: Repomd revision: 1560304655
>2019-06-13T21:09:05Z DEBUG Found updateinfo_zck so using instead of updateinfo
>2019-06-13T21:09:05Z DEBUG lr_yum_use_local: Incomplete repository - /var/cache/dnf/updates-modular-4aefdcf1392b839d/repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck is missing
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Restoring an old SIGINT handler
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using dir: /var/cache/dnf/updates-modular-4aefdcf1392b839d/tmpdir.zQczXl
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Using own SIGINT handler
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Preparing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing internal mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_handle_prepare_internal_mirrorlist: Finalizing mirrors reported via LRI_MIRRORS
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Downloading/Locating yum repo
>2019-06-13T21:09:05Z DEBUG lr_yum_download_remote: Downloading/Copying repo..
>2019-06-13T21:09:05Z DEBUG lr_yum_download_repomd: Downloading repomd.xml via mirrorlist
>2019-06-13T21:09:05Z DEBUG lr_download: Target: repodata/repomd.xml (-)
>2019-06-13T21:09:05Z DEBUG lr_prepare_lrmirrors: Preparing internal mirror list for handle id: 0x560542e95f80
>2019-06-13T21:09:05Z DEBUG lr_prepare_lrmirrors: Mirror: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/
>2019-06-13T21:09:05Z DEBUG select_next_target: Selecting mirror for: repodata/repomd.xml
>2019-06-13T21:09:05Z DEBUG prepare_next_transfer: URL: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/repomd.xml
>2019-06-13T21:09:05Z DEBUG lr_download: Downloading started
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Transfer finished: repodata/repomd.xml (Effective url: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/repomd.xml)
>2019-06-13T21:09:05Z DEBUG lr_yum_download_remote: Parsing repomd.xml
>2019-06-13T21:09:05Z DEBUG 1560304655: Repomd revision: lr_yum_download_remote
>2019-06-13T21:09:05Z DEBUG Found updateinfo_zck so using instead of updateinfo
>2019-06-13T21:09:05Z DEBUG lr_download: Target: repodata/92a88c83c95e3636c183e97ff7defbca24ab71cbdae9faaaebfb9807152332ee-primary.xml.gz (-)
>2019-06-13T21:09:05Z DEBUG lr_prepare_lrmirrors: Preparing internal mirror list for handle id: 0x560542e95f80
>2019-06-13T21:09:05Z DEBUG lr_prepare_lrmirrors: Mirror: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/
>2019-06-13T21:09:05Z DEBUG lr_download: Target: repodata/266677b20b2e3ddc3e2fed5b7a1e9cf4654d29f377ef1adef5642c512ead0241-filelists.xml.gz (-)
>2019-06-13T21:09:05Z DEBUG lr_download: Target: repodata/863596fd1b283b643b33383990f0baa3d37efbbbc6913862a8eeb5707966b0bd-modules.yaml.gz (-)
>2019-06-13T21:09:05Z DEBUG lr_download: Target: repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck (-)
>2019-06-13T21:09:05Z DEBUG select_next_target: Selecting mirror for: repodata/92a88c83c95e3636c183e97ff7defbca24ab71cbdae9faaaebfb9807152332ee-primary.xml.gz
>2019-06-13T21:09:05Z DEBUG prepare_next_transfer: URL: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/92a88c83c95e3636c183e97ff7defbca24ab71cbdae9faaaebfb9807152332ee-primary.xml.gz
>2019-06-13T21:09:05Z DEBUG select_next_target: Selecting mirror for: repodata/266677b20b2e3ddc3e2fed5b7a1e9cf4654d29f377ef1adef5642c512ead0241-filelists.xml.gz
>2019-06-13T21:09:05Z DEBUG prepare_next_transfer: URL: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/266677b20b2e3ddc3e2fed5b7a1e9cf4654d29f377ef1adef5642c512ead0241-filelists.xml.gz
>2019-06-13T21:09:05Z DEBUG select_next_target: Selecting mirror for: repodata/863596fd1b283b643b33383990f0baa3d37efbbbc6913862a8eeb5707966b0bd-modules.yaml.gz
>2019-06-13T21:09:05Z DEBUG prepare_next_transfer: URL: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/863596fd1b283b643b33383990f0baa3d37efbbbc6913862a8eeb5707966b0bd-modules.yaml.gz
>2019-06-13T21:09:05Z DEBUG lr_download: Downloading started
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Transfer finished: repodata/863596fd1b283b643b33383990f0baa3d37efbbbc6913862a8eeb5707966b0bd-modules.yaml.gz (Effective url: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/863596fd1b283b643b33383990f0baa3d37efbbbc6913862a8eeb5707966b0bd-modules.yaml.gz)
>2019-06-13T21:09:05Z DEBUG check_finished_transfer_checksum: Checksum (sha256) 863596fd1b283b643b33383990f0baa3d37efbbbc6913862a8eeb5707966b0bd is OK
>2019-06-13T21:09:05Z DEBUG select_next_target: Selecting mirror for: repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck
>2019-06-13T21:09:05Z DEBUG prepare_next_transfer: URL: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck
>2019-06-13T21:09:05Z DEBUG check_zck: Unable to read zchunk header: repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck
>2019-06-13T21:09:05Z DEBUG find_local_zck_header: Cache directory: /var/cache/dnf
>
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Transfer finished: repodata/92a88c83c95e3636c183e97ff7defbca24ab71cbdae9faaaebfb9807152332ee-primary.xml.gz (Effective url: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/92a88c83c95e3636c183e97ff7defbca24ab71cbdae9faaaebfb9807152332ee-primary.xml.gz)
>2019-06-13T21:09:05Z DEBUG check_finished_transfer_checksum: Checksum (sha256) 92a88c83c95e3636c183e97ff7defbca24ab71cbdae9faaaebfb9807152332ee is OK
>2019-06-13T21:09:05Z DEBUG lr_zckheadercb: Too many ranges were attempted in one download
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Transfer finished: repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck (Effective url: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck)
>2019-06-13T21:09:05Z DEBUG check_finished_transfer_status: Setting mirror's max_ranges to 0
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Error during transfer: repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck's zchunk header doesn't match
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Ignore error - Try another mirror
>2019-06-13T21:09:05Z DEBUG select_next_target: Selecting mirror for: repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck
>2019-06-13T21:09:05Z DEBUG select_suitable_mirror: All mirrors were tried without success
>2019-06-13T21:09:05Z DEBUG select_next_target: Currently there is no free mirror for: repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck
>2019-06-13T21:09:05Z DEBUG check_transfer_statuses: Transfer finished: repodata/266677b20b2e3ddc3e2fed5b7a1e9cf4654d29f377ef1adef5642c512ead0241-filelists.xml.gz (Effective url: http://download.fedoraproject.org/pub/fedora/linux/updates/29/Modular/x86_64/repodata/266677b20b2e3ddc3e2fed5b7a1e9cf4654d29f377ef1adef5642c512ead0241-filelists.xml.gz)
>2019-06-13T21:09:05Z DEBUG check_finished_transfer_checksum: Checksum (sha256) 266677b20b2e3ddc3e2fed5b7a1e9cf4654d29f377ef1adef5642c512ead0241 is OK
>2019-06-13T21:09:05Z DEBUG lr_yum_download_remote: Repository download error: Downloading error(s): repodata/0ae4de5fae98011b4b635497808e2da2b9412de4fb5525180dd96fe958087289-updateinfo.xml.zck - Cannot download, all mirrors were already tried without success
>2019-06-13T21:09:05Z DEBUG lr_handle_perform: Restoring an old SIGINT handler

Actions: View

Attachments on bug 1720381: 1580398 | 1580981