Mailing List Archive

[BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6
openSUSE zypper uses gpg via gpgme to check signatures on the
repository archives against a list of accepted keys. It uses gpgme in
libzypp to do this. For all versions of gpg > 2.2.6 a signature check
failure is observed with strace confirming that gpgme_op_verify is
returning GPG_ERR_GENERAL.

After bisecting, the problem patch turns out to be:

commit e2bd152a928d79ddfb95fd2f7911c80a1a8d5a21 (refs/bisect/bad)
Author: Werner Koch <wk@gnupg.org>
Date: Thu Apr 12 11:49:36 2018 +0200

gpg: Relax printing of STATUS_FAILURE.

And reverting this patch on the openSUSE version of gnupg-2.2.19 allows
zypper to function again.

It's entirely unclear to me why this is the problem, and I so far
haven't succeeded in producing a simplified test case.

James


_______________________________________________
Gnupg-devel mailing list
Gnupg-devel@gnupg.org
http://lists.gnupg.org/mailman/listinfo/gnupg-devel
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Wed, 18 Mar 2020 16:22, James Bottomley said:

> gpg: Relax printing of STATUS_FAILURE.

That is a followup patch for fixing https://dev.gnupg.org/T3872

commit 0336e5d1a7b9d46e06c838e6a98aecfcc9542882
Author: Werner Koch <wk@gnupg.org>
AuthorDate: Fri Apr 6 17:32:08 2018 +0200

gpg: Emit FAILURE stati now in almost all cases.

* g10/cpr.c (write_status_failure): Make it print only once.
* g10/gpg.c (wrong_args): Bump error counter.
(g10_exit): Print a FAILURE status if we ever did a log_error etc.
(main): Use log_error instead of log_fatal at one place. Print a
FAILURE status for a bad option. Ditto for certain exit points so
that we can see different error locations.
--

This makes it easier to detect errors by tools which have no way to
get the exit code (e.g. due to double forking).

Can you please give me a pointer to libzypp so that I can check what is
done there?

Running

GPGME_DEBUG=9:/foo/bar/gpgme.log zypper

should give a large tracefile; I can can have a look at it if you like.


Shalom-Salam,

Werner

--
Die Gedanken sind frei. Ausnahmen regelt ein Bundesgesetz.
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu, 2020-03-19 at 10:11 +0100, Werner Koch wrote:
> On Wed, 18 Mar 2020 16:22, James Bottomley said:
>
> > gpg: Relax printing of STATUS_FAILURE.
>
> That is a followup patch for fixing https://dev.gnupg.org/T3872
>
> commit 0336e5d1a7b9d46e06c838e6a98aecfcc9542882
> Author: Werner Koch <wk@gnupg.org>
> AuthorDate: Fri Apr 6 17:32:08 2018 +0200
>
> gpg: Emit FAILURE stati now in almost all cases.
>
> * g10/cpr.c (write_status_failure): Make it print only once.
> * g10/gpg.c (wrong_args): Bump error counter.
> (g10_exit): Print a FAILURE status if we ever did a log_error
> etc.
> (main): Use log_error instead of log_fatal at one place. Print a
> FAILURE status for a bad option. Ditto for certain exit points
> so
> that we can see different error locations.
> --
>
> This makes it easier to detect errors by tools which have no way
> to
> get the exit code (e.g. due to double forking).
>
> Can you please give me a pointer to libzypp so that I can check what
> is done there?

Yes, it's here:

https://github.com/openSUSE/libzypp

Pretty much all of the key management and signature checking is in

zypp/KeyManager.cc
zypp/KeyRing.cc

> Running
>
> GPGME_DEBUG=9:/foo/bar/gpgme.log zypper
>
> should give a large tracefile; I can can have a look at it if you
> like.

I can get that for you (it's huge, it was the first thing I tried, but
I couldn't even get it to pinpoint the failure. I'll send it under a
separate email). But the way I debugged the issue was to couple the
output of the zypper log (which has quite a few convenient debug
statements) to an strace -s 256 -f which shows the commands going over
the gpg socket.

I've attached the full zypper log of

zypper ref -f

which forces zypper to download every repo. It stops at the first repo
signature check. The relevant line is this one second from bottom:

2020-03-19 08:08:14 <3> jarvis.int.hansenpartnership.com(13858) [zypp::gpg] KeyManager.cc(readSignaturesFprsOptVerify):174 <GnuPG> General error

Which is coming from the gpgme_op_verify in KeyManager.cc

Strace tells me this is what zypper is seeing (22822 is the zypper process and 22869 is gpg2 under gpgme control):

22822 <... select resumed> ) = 1 (in [8], left {tv_sec=0, tv_usec=0})
22869 <... open resumed> ) = 3
22822 read(8, <unfinished ...>
22869 fstat(3, <unfinished ...>
22822 <... read resumed> "[GNUPG:] NEWSIG\n", 1024) = 16
22869 <... fstat resumed> {st_mode=S_IFREG|0644, st_size=2836, ...}) = 0
22822 select(9, [8], [], NULL, {tv_sec=1, tv_usec=0} <unfinished ...>
22869 fstat(3, {st_mode=S_IFREG|0644, st_size=2836, ...}) = 0
22869 read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\5\0\0\0\5\0\0\0\0"..., 4096) = 2836
22869 lseek(3, -1802, SEEK_CUR) = 1034
22869 read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\5\0\0\0\5\0\0\0\0"..., 4096) = 1802
22869 close(3) = 0
22869 write(2, "gpg: Signature made Fri Mar 13 1"..., 48) = 48
22869 write(2, "\n", 1) = 1
22869 write(2, "gpg: using RSA ke"..., 50) = 50
22869 write(2, "\n", 1) = 1
22869 openat(AT_FDCWD, "/var/tmp/zypp.PPpVVx/PublicKey/pubring.kbx", O_RDONLY) = 3
22869 lseek(3, 0, SEEK_CUR) = 0
22869 fstat(3, {st_mode=S_IFREG|0644, st_size=937, ...}) = 0
22869 read(3, "\0\0\0 \1\1\0\2KBXf\0\0\0\0^p\tM^p\tM\0\0\0\0\0\0\0\0"..., 4096) = 937
22869 lseek(3, 0, SEEK_CUR) = 937
22869 write(9, "[GNUPG:] KEY_CONSIDERED F17A9BC0"..., 67 <unfinished ...>
22822 <... select resumed> ) = 1 (in [8], left {tv_sec=0, tv_usec=999217})
22869 <... write resumed> ) = 67
22822 select(9, [8], [], NULL, {tv_sec=0, tv_usec=0}) = 1 (in [8], left {tv_sec=0, tv_usec=0})
22822 read(8, "[GNUPG:] KEY_CONSIDERED F17A9BC0"..., 1024) = 67
22822 select(9, [8], [], NULL, {tv_sec=1, tv_usec=0} <unfinished ...>
22869 openat(AT_FDCWD, "/var/tmp/zypp.PPpVVx/PublicKey/pubring.kbx", O_RDONLY) = 4
22869 lseek(4, 0, SEEK_CUR) = 0
22869 fstat(4, {st_mode=S_IFREG|0644, st_size=937, ...}) = 0
22869 read(4, "\0\0\0 \1\1\0\2KBXf\0\0\0\0^p\tM^p\tM\0\0\0\0\0\0\0\0"..., 4096) = 937
22869 lseek(4, 0, SEEK_CUR) = 937
22869 write(9, "[GNUPG:] KEY_CONSIDERED F17A9BC0"..., 67 <unfinished ...>
22822 <... select resumed> ) = 1 (in [8], left {tv_sec=0, tv_usec=999504})
22869 <... write resumed> ) = 67
22822 select(9, [8], [], NULL, {tv_sec=0, tv_usec=0} <unfinished ...>
22869 close(4 <unfinished ...>
22822 <... select resumed> ) = 1 (in [8], left {tv_sec=0, tv_usec=0})
22869 <... close resumed> ) = 0
22822 read(8, "[GNUPG:] KEY_CONSIDERED F17A9BC0"..., 1024) = 67
22869 stat("/var/tmp/zypp.PPpVVx/PublicKey/trustdb.gpg", <unfinished ...>
22822 select(9, [8], [], NULL, {tv_sec=1, tv_usec=0} <unfinished ...>
22869 <... stat resumed> {st_mode=S_IFREG|0600, st_size=1200, ...}) = 0
22869 openat(AT_FDCWD, "/var/tmp/zypp.PPpVVx/PublicKey/trustdb.gpg", O_RDWR) = 4
22869 lseek(4, 0, SEEK_SET) = 0
22869 read(4, "\1gpg\3\3\1\5\1\2\0\0^p\tM\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 0, SEEK_SET) = 0
22869 read(4, "\1gpg\3\3\1\5\1\2\0\0^p\tM\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 40, SEEK_SET) = 40
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 80, SEEK_SET) = 80
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 120, SEEK_SET) = 120
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 160, SEEK_SET) = 160
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 200, SEEK_SET) = 200
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 240, SEEK_SET) = 240
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 280, SEEK_SET) = 280
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 320, SEEK_SET) = 320
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 360, SEEK_SET) = 360
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 400, SEEK_SET) = 400
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 440, SEEK_SET) = 440
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 480, SEEK_SET) = 480
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 520, SEEK_SET) = 520
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 560, SEEK_SET) = 560
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 600, SEEK_SET) = 600
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 640, SEEK_SET) = 640
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 680, SEEK_SET) = 680
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 720, SEEK_SET) = 720
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 760, SEEK_SET) = 760
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 800, SEEK_SET) = 800
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 840, SEEK_SET) = 840
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 880, SEEK_SET) = 880
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 920, SEEK_SET) = 920
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 960, SEEK_SET) = 960
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 1000, SEEK_SET) = 1000
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 1040, SEEK_SET) = 1040
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 1080, SEEK_SET) = 1080
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 1120, SEEK_SET) = 1120
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 1160, SEEK_SET) = 1160
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 1200, SEEK_SET) = 1200
22869 read(4, "", 40) = 0
22869 lseek(4, 0, SEEK_SET) = 0
22869 read(4, "\1gpg\3\3\1\5\1\2\0\0^p\tM\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 0, SEEK_SET) = 0
22869 read(4, "\1gpg\3\3\1\5\1\2\0\0^p\tM\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 0, SEEK_SET) = 0
22869 read(4, "\1gpg\3\3\1\5\1\2\0\0^p\tM\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 lseek(4, 1080, SEEK_SET) = 1080
22869 read(4, "\n\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 40) = 40
22869 write(9, "[GNUPG:] BADSIG 668EA451E1B7CFAD"..., 110) = 110
22822 <... select resumed> ) = 1 (in [8], left {tv_sec=0, tv_usec=996542})
22869 write(2, "gpg: BAD signature from \"home:je"..., 111 <unfinished ...>
22822 select(9, [8], [], NULL, {tv_sec=0, tv_usec=0} <unfinished ...>
22869 <... write resumed> ) = 111
22822 <... select resumed> ) = 1 (in [8], left {tv_sec=0, tv_usec=0})
22869 write(2, "]\n", 2 <unfinished ...>
22822 read(8, <unfinished ...>
22869 <... write resumed> ) = 2
22822 <... read resumed> "[GNUPG:] BADSIG 668EA451E1B7CFAD"..., 1024) = 110
22869 write(9, "[GNUPG:] VERIFICATION_COMPLIANCE"..., 41 <unfinished ...>
22822 select(9, [8], [], NULL, {tv_sec=1, tv_usec=0} <unfinished ...>
22869 <... write resumed> ) = 41
22822 <... select resumed> ) = 1 (in [8], left {tv_sec=0, tv_usec=999998})
22869 write(9, "[GNUPG:] FAILURE gpg-exit 335544"..., 35 <unfinished ...>

James

---

2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] main.cc(main):97 ===== Hi, me zypper 1.14.33
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] main.cc(main):98 ===== 'zypper' 'ref' '-f' =====
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(_autodetectSystemArchitecture):73 Uname architecture is 'x86_64'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(_autodetectTextLocale):202 Found LANG=en_US.UTF-8
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(_autodetectTextLocale):209 Default text locale is 'en_US'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(Impl):342 libzypp: 17.19.0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/zypp.conf[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/zypp.conf[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#1|/etc/zypp/zypp.conf}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(Impl):618 ZConfig singleton created.
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(ZConfig):819 libzypp: 17.19.0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(ZConfig):819 libsolv: 0.7.10
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(ZConfig):819 zypp.conf: '/etc/zypp/zypp.conf'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(ZConfig):819 TextLocale: 'en_US' (en_US)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zconfig] ZConfig.cc(ZConfig):819 SystemArchitecture: 'x86_64' (x86_64)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(assert_dir):354 mkdir /var/tmp/zypp.SwKyrE/zypper 00755
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Zypper.cc(Zypper):189 Zypper instance created.
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] media.h(MediaCallbacks):204 Set media callbacks..
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Zypper.cc(processGlobalOptions):300 START
2020-03-19 08:08:12 <5> jarvis.int.hansenpartnership.com(13858) [Measure] Measure.cc(log):178 START MEASURE(ReadConfig)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Augeas.cc(Augeas):539 Going to read zypper config using Augeas...
2020-03-19 08:08:12 <2> jarvis.int.hansenpartnership.com(13858) [zypper] Augeas.cc(Augeas):607 MISS config file: /root/.zypper.conf
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Augeas.cc(Augeas):601 READ config file: /etc/zypp/zypper.conf
2020-03-19 08:08:12 <5> jarvis.int.hansenpartnership.com(13858) [Measure] Measure.cc(log):178 ELAPSED(ReadConfig) 0 (u 0.01 s 0.00 c 0.00)
2020-03-19 08:08:12 <5> jarvis.int.hansenpartnership.com(13858) [Measure] Measure.cc(log):178 MEASURE(ReadConfig) 0 (u 0.01 s 0.00 c 0.00) [0 (u 0.00 s 0.00 c 0.00)]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] Zypper.cc(processGlobalOptions):311 Verbosity 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] Zypper.cc(processGlobalOptions):312 Output type 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] Zypper.cc(processGlobalOptions):350 repos.d dir = /etc/zypp/repos.d
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] Zypper.cc(processGlobalOptions):351 cache dir = /var/cache/zypp
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] Zypper.cc(processGlobalOptions):352 raw cache dir = /var/cache/zypp/raw
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] Zypper.cc(processGlobalOptions):353 solv cache dir = /var/cache/zypp/solv
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] Zypper.cc(processGlobalOptions):354 package cache dir = /var/cache/zypp/packages
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Zypper.cc(processGlobalOptions):358 Repositories enabled
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Zypper.cc(processGlobalOptions):361 DONE
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Zypper.cc(doCommand):487 START
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppFactory.cc(_openLockFile):168 Open lockfile /var/run/zypp.pid
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppFactory.cc(readLockFile):223 read: Lockfile /var/run/zypp.pid has pid 0 (our pid: 13858)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppFactory.cc(writeLockFile):235 write: Lockfile /var/run/zypp.pid got pid 13858
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppFactory.cc(_closeLockFile):186 Close lockfile /var/run/zypp.pid
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppImpl.cc(ZYppImpl):71 libzypp: 17.19.0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppImpl.cc(ZYppImpl):71 libsolv: 0.7.10
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppImpl.cc(ZYppImpl):71 zypp.conf: '/etc/zypp/zypp.conf'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppImpl.cc(ZYppImpl):71 TextLocale: 'en_US' (en_US)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppImpl.cc(ZYppImpl):71 SystemArchitecture: 'x86_64' (x86_64)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppImpl.cc(ZYppImpl):72 Initializing keyring...
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(Impl):188 Current KeyRing::DefaultAccept: 0000000000
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppFactory.cc(ZYpp):312 ZYpp is on...
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Zypper.cc(doCommand):629 Going to process command refresh
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] Zypper.cc(doCommand):638 Found new style command << refresh
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] basecommand.cc(parseArguments):124 Done parsing options.
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] basecommand.cc(run):239 run: refresh
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] basecommand.cc(defaultSystemSetup):163 FLAGS:[ResetRepoManager]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /etc/zypp/services.d
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /usr/lib/zypp/plugins/services
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(init_knownRepositories):829 start construct known repos
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_dir):307 directory /etc/zypp/repos.d
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /etc/zypp/repos.d
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-update.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-update.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-update.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#2|/etc/zypp/repos.d/repo-update.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-update
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Update
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/update/leap/15.1/oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-update.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-update-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-update-non-oss.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-update-non-oss.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#3|/etc/zypp/repos.d/repo-update-non-oss.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-update-non-oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Update-Non-Oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/update/leap/15.1/non-oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-update-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-non-oss.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-non-oss.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#4|/etc/zypp/repos.d/repo-non-oss.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-non-oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Non-Oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/distribution/leap/15.1/repo/non-oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-debug.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-debug.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-debug.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#5|/etc/zypp/repos.d/repo-debug.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-debug
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Debug
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/debug/distribution/leap/15.1/repo/oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-debug.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-debug-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-debug-non-oss.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-debug-non-oss.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#6|/etc/zypp/repos.d/repo-debug-non-oss.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-debug-non-oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Debug-Non-Oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/debug/distribution/leap/15.1/repo/non-oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : NONE
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-debug-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-debug-update.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-debug-update.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-debug-update.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#7|/etc/zypp/repos.d/repo-debug-update.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-debug-update
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Update-Debug
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/debug/update/leap/15.1/oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-debug-update.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-debug-update-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-debug-update-non-oss.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-debug-update-non-oss.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#8|/etc/zypp/repos.d/repo-debug-update-non-oss.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-debug-update-non-oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Update-Debug-Non-Oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/debug/update/leap/15.1/non-oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : NONE
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-debug-update-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-source.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-source.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-source.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#9|/etc/zypp/repos.d/repo-source.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-source
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Source
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/source/distribution/leap/15.1/repo/oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : NONE
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-source.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-source-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-source-non-oss.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-source-non-oss.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#10|/etc/zypp/repos.d/repo-source-non-oss.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-source-non-oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-Source-Non-Oss
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/source/distribution/leap/15.1/repo/non-oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : NONE
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-source-non-oss.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/packman.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/packman.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/packman.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#11|/etc/zypp/repos.d/packman.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : packman
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://ftp.gwdg.de/pub/linux/misc/packman/suse/openSUSE_Leap_15.1/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/packman.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/jejb-tumbleweed.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/jejb-tumbleweed.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/jejb-tumbleweed.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#12|/etc/zypp/repos.d/jejb-tumbleweed.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : jejb-tumbleweed
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : jejb-tumbleweed
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : Y repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/jejb-tumbleweed.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/jejb-tumbleweed-gnome.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/jejb-tumbleweed-gnome.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/jejb-tumbleweed-gnome.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#13|/etc/zypp/repos.d/jejb-tumbleweed-gnome.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : jejb-tumbleweed-gnome
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : jejb-tumbleweed-gnome
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed:/gnome-leap-15/openSUSE_Leap_15.1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/jejb-tumbleweed-gnome.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(repositories_in_file):289 repo file: /etc/zypp/repos.d/repo-install.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):84 Start parsing /etc/zypp/repos.d/repo-install.repo[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] IniParser.cc(parse):138 Done parsing /etc/zypp/repos.d/repo-install.repo[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#14|/etc/zypp/repos.d/repo-install.repo}END
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 --------------------------------------
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - alias : repo-install
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - name : openSUSE-Leap-15.1-1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - enabled : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - autorefresh : 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - url : http://download.opensuse.org/distribution/leap/15.1/repo/oss/
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - path : /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - type : rpm-md
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - priority : 99
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - gpgcheck : D(Y) repoD(Y)* sig? pkgD(Y)*
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - keeppackages: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191 - filePath: /etc/zypp/repos.d/repo-install.repo
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoFileReader.cc(repositories_in_stream):191
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /var/cache/zypp/raw
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /var/cache/zypp/solv
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /var/cache/zypp/packages
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(init_knownRepositories):889 end construct known repos
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] refresh.cc(execute):132 going to refresh repositories
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper++] basecommand.cc(defaultSystemSetup):163 FLAGS:[InitTarget]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] repos.cc(init_target):981 Initializing target
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ZYppImpl.cc(initializeTarget):122 initTarget( /)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] librpmDb.cc(globalInit):148 librpm init done: (_target:x86_64-linux) (_dbpath:/usr/lib/sysimage/rpm)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(initDatabase):345 Calling initDatabase: '(/)/var/lib/rpm'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] librpmDb.cc(unblockAccess):344 Unblock access
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(DbDirInfo):522 '(/)/var/lib/rpm':
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(DbDirInfo):522 Dir: /var/lib/rpm{d 0755 0/0}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(DbDirInfo):522 V4: /var/lib/rpm/Packages{- 0644 0/0 size 227815424}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(DbDirInfo):522 V3: /var/lib/rpm/packages.rpm{[2-No such file or directory]}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(DbDirInfo):522 V3ToV4: /var/lib/rpm/packages.rpm3{[2-No such file or directory]}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(internal_initDatabase):468 Found rpm4 database in /var/lib/rpm{d 0755 0/0}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] RpmDb.cc(internal_initDatabase):485 Initial state: V4(X--)V3(---): '(/)/var/lib/rpm'[librpmDb CLOSED '(/)/var/lib/rpm']
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] librpmDb.cc(dbAccess):240 Set new database location: '(/)/var/lib/rpm'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(D):100 DBACCESS {NULL(/)/var/lib/rpm}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] RpmDb.cc(internal_initDatabase):504 Access state: V4(X--)V3(---): '(/)/var/lib/rpm'[ReferenceCounted(@0x55c07fac1900<=1){NULL(/)/var/lib/rpm}]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(dbRelease):311 dbRelease: release, outstanding 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(initDatabase):426 Synchronizing keys with zypp keyring
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(syncTrustedKeys):961 Going to sync trusted keys...
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(D):100 DBACCESS {NULL(/)/var/lib/rpm}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(dbRelease):311 dbRelease: release, outstanding 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] RpmDb.cc(computeKeyRingSync):941 gpg-pubkey-1abd1afb-54176598 R_
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] RpmDb.cc(computeKeyRingSync):941 gpg-pubkey-307e3d54-5aaa90a5 R_
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] RpmDb.cc(computeKeyRingSync):941 gpg-pubkey-39db7c82-5847eb1f R_
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] RpmDb.cc(computeKeyRingSync):941 gpg-pubkey-3dbdc284-53674dd4 R_
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] RpmDb.cc(computeKeyRingSync):941 gpg-pubkey-e1b7cfad-5c52e23e R_
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(syncTrustedKeys):993 Rpm keys to export into zypp trusted keyring: 5
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(syncTrustedKeys):994 Zypp trusted keys to import into rpm database: 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(syncTrustedKeys):1000 Exporting rpm keyring into zypp trusted keyring
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(D):100 DBACCESS {NULL(/)/var/lib/rpm}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg++] KeyManager.cc(createForOpenPGP):239 createForOpenPGP(/var/tmp/zypp.SwKyrE/zypp-trusted-krM8rgLG)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg] KeyManager.cc(initGpgme):44 Initialized libgpgme version: 1.10.0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg++] KeyManager.cc(createForOpenPGP):239 createForOpenPGP(/var/tmp/zypp.SwKyrE/zypp-trusted-krM8rgLG)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(getData):166 Found keys: {
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(getData):166 [668EA451E1B7CFAD-5c52e23e] [home:jejb1:Tumbleweed OBS Project <home:jejb1:Tumbleweed@build.opensuse.org>] [expires: 2021-04-10]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(getData):166 [45A1D0671ABD1AFB-54176598] [PackMan Project (signing key) <packman@links2linux.de>] [expires: 2024-09-12]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(getData):166 [B88B2FD43DBDC284-53674dd4] [openSUSE Project Signing Key <opensuse@opensuse.org>] [expires: 2024-05-02]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(getData):166 [70AF9E8139DB7C82-5847eb1f] [SuSE Package Signing Key <build@suse.de>] [expires: 2020-12-06]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(getData):166 [E3A5C360307E3D54-5aaa90a5] [SuSE Package Signing Key <build@suse.de>] [expires: 2022-03-14]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(getData):166 }
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(publicKeyExists):366 Found key [e1b7cfad] in keyring /var/tmp/zypp.SwKyrE/zypp-trusted-krM8rgLG
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(publicKeyExists):366 Found key [1abd1afb] in keyring /var/tmp/zypp.SwKyrE/zypp-trusted-krM8rgLG
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(publicKeyExists):366 Found key [3dbdc284] in keyring /var/tmp/zypp.SwKyrE/zypp-trusted-krM8rgLG
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(publicKeyExists):366 Found key [39db7c82] in keyring /var/tmp/zypp.SwKyrE/zypp-trusted-krM8rgLG
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(publicKeyExists):366 Found key [307e3d54] in keyring /var/tmp/zypp.SwKyrE/zypp-trusted-krM8rgLG
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(unlink):659 unlink /var/tmp/zypp.SwKyrE/TmpFile.Y0jksL
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] TmpPath.cc(~Impl):78 TmpPath cleaned up /var/tmp/zypp.SwKyrE/TmpFile.Y0jksL{- 0600 0/0 size 7250}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb++] librpmDb.cc(dbRelease):311 dbRelease: release, outstanding 0
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(syncTrustedKeys):1057 Trusted keys synced.
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [librpmDb] RpmDb.cc(initDatabase):435 InitDatabase: RpmDb[V4(X--)V3(---): '(/)/var/lib/rpm']
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] HistoryLog.cc(setRoot):173 installation log file /var/log/zypp/history
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] TargetImpl.cc(TargetImpl):698 Initialized target on /
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /etc/products.d
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] TargetImpl.cc(buildCache):853 Read cookie: /var/cache/zypp/solv/@System/cookie{- 0644 0/0 size 52}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] TargetImpl.cc(buildCache):860 Read cookie: /var/cache/zypp/solv/@System/cookie says: uptodate
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] refresh.cc(refreshRepository):147 going to refresh repo 'jejb-tumbleweed'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypper] refresh.cc(refreshRepository):154 calling refreshMetadata, forced
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(checkIfToRefreshMetadata):971 Going to try to check whether refresh is needed for http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 (rpm-md)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(checkIfToRefreshMetadata):991 Forced refresh!
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(refreshMetadata):1110 Going to refresh metadata from http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(probe):1410 going to probe the repo type at http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 ()
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaAccess.cc(open):117 Trying scheme 'http'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaCurl.cc(MediaCurl):549 MediaCurl::MediaCurl(http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1, )
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaMultiCurl.cc(MediaMultiCurl):1164 MediaMultiCurl::MediaMultiCurl(http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1, )
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaAccess.cc(open):197 Opened: http(http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 not attached; localRoot "")
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(open):258 Opened new media access using id 1 to http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(provide):253 Going to try to provide file /repodata/repomd.xml from media number 1
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(attach):376 attach(id=1)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(createAttachPoint):391 Create attach point: attach root is not a writable directory: '/var/adm/mount'
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(createAttachPoint):400 Look for orphaned attach points in /var/tmp{d 1777 0/0}
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(dirForEach):553 readdir /var/tmp
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(createAttachPoint):374 Created default attach point /var/tmp/AP_0x8OiTXN
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ProductFileReader.cc(parse):219 +++/etc/products.d/baseproduct[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] Reader.cc(Reader):113 Start Parsing /etc/products.d/baseproduct[g___]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] Reader.cc(~Reader):137 Done Parsing /etc/products.d/baseproduct[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ProductFileReader.cc(parse):245 ---0 - /etc/products.d/baseproduct[_eF_]
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] ProxyInfoLibproxy.cc(getProxyFactory):66 Build Libproxy Factory from /etc/sysconfig/proxy
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(setupEasy):829 Proxy: not explicitly set
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(setupEasy):830 Proxy: libcurl may look into the environment
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(chmod):1051 assert_file_mode 00600 /var/lib/YaST2/cookieschmod /var/lib/YaST2/cookies 00600
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(attach):691 Attached: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 attached; localRoot "/var/tmp/AP_0x8OiTXN"
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):96 checkDesired(1): desired (report by zypp::media::NoVerifier)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(1): desired (cached)
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetDoesFileExist):1190 /repodata/repomd.xml
2020-03-19 08:08:12 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetDoesFileExist):1200 URL: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1/repodata/repomd.xml
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaCurl.cc(doGetDoesFileExist):1281 perform code: 0 [ No error ]
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(1): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(probe):1436 Probed type RPMMD at http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 ()
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(close):288 Close to access handler using id 1 requested
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(release):751 Request to release attached media http<http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1>, use count=1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(release):758 Releasing media http<http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1>
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(disconnect):730 Disconnected: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 attached; localRoot "/var/tmp/AP_0x8OiTXN"
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(removeAttachPoint):181 MediaHandler - checking if to remove attach point
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(recursive_rmdir):426 recursive_rmdir /var/tmp/AP_0x8OiTXN
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(removeAttachPoint):193 Deleted default attach point /var/tmp/AP_0x8OiTXN
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(release):812 Released: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 not attached; localRoot ""
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaAccess.cc(close):248 Close: http(http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 not attached; localRoot "") (OK)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(release):744 Request to release media - not attached; eject ''
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(removeAttachPoint):181 MediaHandler - checking if to remove attach point
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] RepoManager.cc(refreshMetadata):1158 Creating downloader for [ jejb-tumbleweed ]
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/jejb-tumbleweed'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/jejb-tumbleweed-gnome'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/packman'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/repo-debug'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/repo-debug-update'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/repo-install'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/repo-non-oss'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/repo-update'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher++] Fetcher.cc(addCachePath):316 Adding fetcher cache: '/var/cache/zypp/raw/repo-update-non-oss'.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(downloadAndReadIndexList):690 No indexes to read.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(provideToDest):518 Not found in cache, retrieving...
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaAccess.cc(open):117 Trying scheme 'http'
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaCurl.cc(MediaCurl):549 MediaCurl::MediaCurl(http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1, )
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaMultiCurl.cc(MediaMultiCurl):1164 MediaMultiCurl::MediaMultiCurl(http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1, )
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaAccess.cc(open):197 Opened: http(http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 not attached; localRoot "")
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(open):258 Opened new media access using id 2 to http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(provide):253 Going to try to provide optional file /media.1/media from media number 1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(attach):376 attach(id=2)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(createAttachPoint):391 Create attach point: attach root is not a writable directory: '/var/adm/mount'
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(createAttachPoint):374 Created default attach point /var/tmp/AP_0xCglbPW
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(setupEasy):829 Proxy: not explicitly set
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(setupEasy):830 Proxy: libcurl may look into the environment
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(chmod):1051 assert_file_mode 00600 /var/lib/YaST2/cookieschmod /var/lib/YaST2/cookies 00600
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(attach):691 Attached: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 attached; localRoot "/var/tmp/AP_0xCglbPW"
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):96 checkDesired(2): desired (report by zypp::media::NoVerifier)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(assert_dir):354 mkdir /var/tmp/AP_0xCglbPW/media.1 00755
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1334 dest: /var/tmp/AP_0xCglbPW/media.1/media
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1335 temp: /var/tmp/AP_0xCglbPW/media.1/media.new.zypp.MKR2f1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1486 /media.1/media
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1496 URL: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1/media.1/media
2020-03-19 08:08:13 <3> jarvis.int.hansenpartnership.com(13858) [zypp] MediaCurl.cc(doGetFileCopyFile):1561 curl error: 22: The requested URL returned error: 404 Not Found, temp file size 0 bytes.
2020-03-19 08:08:13 <5> jarvis.int.hansenpartnership.com(13858) [zypp] Exception.cc(log):166 MediaCurl.cc(evaluateCurlCode):1119 THROW: File '/media.1/media' not found on medium 'http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1'
2020-03-19 08:08:13 <5> jarvis.int.hansenpartnership.com(13858) [zypp] Exception.cc(log):166 MediaCurl.cc(doGetFileCopyFile):1577 RETHROW: File '/media.1/media' not found on medium 'http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1'
2020-03-19 08:08:13 <5> jarvis.int.hansenpartnership.com(13858) [zypp] Exception.cc(log):166 MediaMultiCurl.cc(doGetFileCopy):1363 RETHROW: File '/media.1/media' not found on medium 'http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1'
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(unlink):659 unlink /var/tmp/AP_0xCglbPW/media.1/media.new.zypp.MKR2f1
2020-03-19 08:08:13 <5> jarvis.int.hansenpartnership.com(13858) [zypp] Exception.cc(log):166 MediaCurl.cc(getFileCopy):1006 RETHROW: File '/media.1/media' not found on medium 'http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1'
2020-03-19 08:08:13 <5> jarvis.int.hansenpartnership.com(13858) [zypp] Exception.cc(log):166 MediaSetAccess.cc(provide):266 CAUGHT: File '/media.1/media' not found on medium 'http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1'
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(getDetectedDevices):1398 No devices for this medium
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(provide):278 Media couldn't provide file /media.1/media , releasing.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(release):447 release(id=2)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(release):751 Request to release attached media http<http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1>, use count=1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(release):758 Releasing media http<http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1>
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(disconnect):730 Disconnected: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 attached; localRoot "/var/tmp/AP_0xCglbPW"
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(removeAttachPoint):181 MediaHandler - checking if to remove attach point
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(recursive_rmdir):426 recursive_rmdir /var/tmp/AP_0xCglbPW
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(removeAttachPoint):193 Deleted default attach point /var/tmp/AP_0xCglbPW
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(release):812 Released: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 not attached; localRoot ""
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaSetAccess.cc(provide):314 Can't provide file. Non-Interactive mode.
2020-03-19 08:08:13 <5> jarvis.int.hansenpartnership.com(13858) [zypp] Exception.cc(log):166 MediaSetAccess.cc(provide):315 RETHROW: File '/media.1/media' not found on medium 'http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1'
2020-03-19 08:08:13 <5> jarvis.int.hansenpartnership.com(13858) [zypp] Exception.cc(log):166 Fetcher.cc(provideToDest):549 CAUGHT: File '/media.1/media' not found on medium 'http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1'
2020-03-19 08:08:13 <2> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(provideToDest):550 optional resource [1]/media.1/media{19.1 MiB|NoCheckSum} could not be transferred.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#15|}END
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(downloadAndReadIndexList):690 No indexes to read.
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(provideToDest):518 Not found in cache, retrieving...
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(provide):253 Going to try to provide optional file /repodata/repomd.xml.asc from media number 1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(attach):376 attach(id=2)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(createAttachPoint):391 Create attach point: attach root is not a writable directory: '/var/adm/mount'
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(createAttachPoint):374 Created default attach point /var/tmp/AP_0xOFkuw6
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(setupEasy):829 Proxy: not explicitly set
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(setupEasy):830 Proxy: libcurl may look into the environment
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(chmod):1051 assert_file_mode 00600 /var/lib/YaST2/cookieschmod /var/lib/YaST2/cookies 00600
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] MediaHandler.cc(attach):691 Attached: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1 attached; localRoot "/var/tmp/AP_0xOFkuw6"
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):96 checkDesired(2): desired (report by zypp::media::NoVerifier)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(assert_dir):354 mkdir /var/tmp/AP_0xOFkuw6/repodata 00755
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1334 dest: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1335 temp: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc.new.zypp.8G9YMb
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1486 /repodata/repomd.xml.asc
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1496 URL: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1/repodata/repomd.xml.asc
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(progressCallback):1284 looks_like_metalink_fd: 0
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1373 HTTP response: 200
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(looks_like_metalink):1240 looks_like_metalink(/var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc.new.zypp.8G9YMb): 0
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(rename):701 rename /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc.new.zypp.8G9YMb -> /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1493 done: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc{- 0644 0/0 size 481}
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(provideFile):1015 provideFile(/repodata/repomd.xml.asc)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(validate):366 Checking job [/var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc] (0 checkers )
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(assert_dir):354 mkdir /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata 00755
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(hardlinkCopy):869 hardlinkCopy /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc -> /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata/repomd.xml.asc
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(releaseFile):88 Going to release file /repodata/repomd.xml.asc from media number 1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(unlink):659 unlink /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.asc
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(provideToDest):518 Not found in cache, retrieving...
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(provide):253 Going to try to provide optional file /repodata/repomd.xml.key from media number 1
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1334 dest: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1335 temp: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key.new.zypp.S1F4Zh
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1486 /repodata/repomd.xml.key
2020-03-19 08:08:13 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1496 URL: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1/repodata/repomd.xml.key
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(progressCallback):1284 looks_like_metalink_fd: 0
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1373 HTTP response: 200
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(looks_like_metalink):1240 looks_like_metalink(/var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key.new.zypp.S1F4Zh): 0
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(rename):701 rename /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key.new.zypp.S1F4Zh -> /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1493 done: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key{- 0644 0/0 size 1121}
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(provideFile):1015 provideFile(/repodata/repomd.xml.key)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(validate):366 Checking job [/var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key] (0 checkers )
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(hardlinkCopy):869 hardlinkCopy /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key -> /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata/repomd.xml.key
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(releaseFile):88 Going to release file /repodata/repomd.xml.key from media number 1
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(unlink):659 unlink /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.key
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [Progress++] ProgressData.cc(report):88 {#16|}END
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg] PublicKey.cc(Impl):396 Taking pubkey from /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata/repomd.xml.key of size 1121 and sha1 4b76f8e3965fe663a637ef6ce0f53513662db7e4
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(unlink):659 hardlinkCopy /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata/repomd.xml.key -> /var/tmp/TmpFile.gTtEcpunlink /var/tmp/TmpFile.gTtEcp
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(hardlinkCopy):869
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg] PublicKey.cc(readFromFile):442 Reading pubkey from /var/tmp/TmpFile.gTtEcp of size 1121 and sha1 4b76f8e3965fe663a637ef6ce0f53513662db7e4
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(assert_dir):354 mkdir /var/tmp/zypp.SwKyrE/PublicKey 00755
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg++] KeyManager.cc(createForOpenPGP):239 createForOpenPGP(/var/tmp/zypp.SwKyrE/PublicKey)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(clean_dir):447 clean_dir /var/tmp/zypp.SwKyrE/PublicKey
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg] PublicKey.cc(readFromFile):465 Read pubkey from /var/tmp/TmpFile.gTtEcp: [668EA451E1B7CFAD-5c52e23e] [home:jejb1:Tumbleweed OBS Project <home:jejb1:Tumbleweed@build.opensuse.org>] [expires: 2021-04-10]
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg++] KeyManager.cc(createForOpenPGP):239 createForOpenPGP(/var/tmp/zypp.SwKyrE/zypp-general-kriTBY4I)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(importKey):302 Imported key [668EA451E1B7CFAD-5c52e23e] [home:jejb1:Tumbleweed OBS Project <home:jejb1:Tumbleweed@build.opensuse.org>] [expires: 2021-04-10] to generalKeyRing
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(unlink):659 unlink /var/tmp/TmpFile.gTtEcp
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] TmpPath.cc(~Impl):78 TmpPath cleaned up /var/tmp/TmpFile.gTtEcp{- 0644 0/0 size 1121}
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(downloadAndReadIndexList):690 No indexes to read.
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(provideToDest):518 Not found in cache, retrieving...
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaSetAccess.cc(provide):253 Going to try to provide file /repodata/repomd.xml from media number 1
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1334 dest: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1335 temp: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.new.zypp.O8avzw
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1486 /repodata/repomd.xml
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaCurl.cc(doGetFileCopyFile):1496 URL: http://download.opensuse.org/repositories/home:/jejb1:/Tumbleweed/openSUSE_Leap_15.1/repodata/repomd.xml
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(progressCallback):1284 looks_like_metalink_fd: 0
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1373 HTTP response: 200
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(looks_like_metalink):1240 looks_like_metalink(/var/tmp/AP_0xOFkuw6/repodata/repomd.xml.new.zypp.O8avzw): 0
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp] PathInfo.cc(rename):701 rename /var/tmp/AP_0xOFkuw6/repodata/repomd.xml.new.zypp.O8avzw -> /var/tmp/AP_0xOFkuw6/repodata/repomd.xml
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaMultiCurl.cc(doGetFileCopy):1493 done: /var/tmp/AP_0xOFkuw6/repodata/repomd.xml{- 0644 0/0 size 1715}
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaHandler.cc(provideFile):1015 provideFile(/repodata/repomd.xml)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp++] MediaManager.cc(checkDesired):98 checkDesired(2): desired (cached)
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp:fetcher] Fetcher.cc(validate):366 Checking job [/var/tmp/AP_0xOFkuw6/repodata/repomd.xml] (1 checkers )
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [FileChecker] FileChecker.cc(operator()):138 checking /var/tmp/AP_0xOFkuw6/repodata/repomd.xml file validity using digital signature..
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(verifyFileSignatureWorkflow):408 Going to verify signature for repomd.xml ( /var/tmp/AP_0xOFkuw6/repodata/repomd.xml ) with /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata/repomd.xml.asc
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(readSignatureKeyId):611 Determining key id of signature /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata/repomd.xml.asc
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg++] KeyManager.cc(createForOpenPGP):239 createForOpenPGP(/var/tmp/zypp.SwKyrE/PublicKey)
2020-03-19 08:08:14 <3> jarvis.int.hansenpartnership.com(13858) [zypp::gpg] KeyManager.cc(readSignaturesFprsOptVerify):174 <GnuPG> General error
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(verifyFileSignatureWorkflow):515 File [/var/tmp/AP_0xOFkuw6/repodata/repomd.xml] ( repomd.xml ) signed with unknown key []
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu, 2020-03-19 at 10:11 +0100, Werner Koch wrote:
> Running
>
> GPGME_DEBUG=9:/foo/bar/gpgme.log zypper
>
> should give a large tracefile; I can can have a look at it if you
> like.

First reply is stuck in moderation. This has the compressed gpgme log

James
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu, 2020-03-19 at 08:21 -0700, James Bottomley via Gnupg-devel
wrote:
> On Thu, 2020-03-19 at 10:11 +0100, Werner Koch wrote:
> > Running
> >
> > GPGME_DEBUG=9:/foo/bar/gpgme.log zypper
> >
> > should give a large tracefile; I can can have a look at it if you
> > like.
>
> First reply is stuck in moderation. This has the compressed gpgme
> log

I should add for the first reply that when I go in and run gpg manually
over exactly the directories and files the gpgme code is using,
verification succeeds, and when I try to do the same thing using a test
programme built on gpgme everything also succeeds, so whatever is
happening seems to be something to do with the sequence of prior
operations zypper did.

James
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu 2020-03-19 08:25:03 -0700, James Bottomley via Gnupg-devel wrote:
> On Thu, 2020-03-19 at 08:21 -0700, James Bottomley via Gnupg-devel wrote:
>> First reply is stuck in moderation. This has the compressed gpgme
>> log
>
> I should add for the first reply that when I go in and run gpg manually
> over exactly the directories and files the gpgme code is using,
> verification succeeds, and when I try to do the same thing using a test
> programme built on gpgme everything also succeeds, so whatever is
> happening seems to be something to do with the sequence of prior
> operations zypper did.

Thanks for this log, James.

From the log, there are 5 gpgme invocations: gpgme_op_import,
gpgme_op_keylist, gpgme_op_import, gpgme_op_keylist, gpgme_op_verify.

It looks to me like the failure is in the final call to gpgme_op_verify.

In that call, gpgme is feeding the signature via fd 12 (0xc)
successfully to the spawned gpg process's fd 11. This is correct, given
the first non-option argument -&11. But it also needs to send the data
via fd 14 (0xe) to gpg's fd 13, given the second non-option argument
-&13.

However it looks like it feeds it the empty string instead of any data
that might have been signed:

GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_data_outbound_handler: enter: dh=0x55aada91b5c0, fd=0xe
GPGME 2020-03-19 08:19:04 <0x3839> gpgme_data_read: enter: dh=0x55aada91b5c0, buffer=0x55aada91b5cc, size=4096
GPGME 2020-03-19 08:19:04 <0x3839> gpgme_data_read: leave: result=0
GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_io_close: enter: fd=0xe
GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_io_close: check: fd=0xe, invoking close handler 0x7f1e4272bfe0/0x55aadaa39aa0
GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_remove_io_cb: call: data=0x55aada9ac5c0, setting fd 0xe (item=0x55aada8d2890) done
GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_io_close: leave: result=0
GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_data_outbound_handler: leave


Is it possible that the data object being passed to gpgme is corrupted
somehow?

Also, you say that zypper works if you revert this patch. have you
tested this "working" configuration against a deliberately tampered
message body? To test that it is working, it's best to verify both that
a valid message is accepted *and* that a tampered message is rejected.

This is gpg's status response, fwiw:

[GNUPG:] PROGRESS -&11 ? 0 0 B
[GNUPG:] PROGRESS -&11 ? 481 0 B
[GNUPG:] PROGRESS -&13 ? 0 0 B
[GNUPG:] NEWSIG
[GNUPG:] KEY_CONSIDERED F17A9BC0C01F2AEE49F779EE668EA451E1B7CFAD 0
[GNUPG:] KEY_CONSIDERED F17A9BC0C01F2AEE49F779EE668EA451E1B7CFAD 0
[GNUPG:] BADSIG 668EA451E1B7CFAD home:jejb1:Tumbleweed OBS Project <home:jejb1:Tumbleweed@build.opensuse.org>
[GNUPG:] VERIFICATION_COMPLIANCE_MODE 23
[GNUPG] FAILURE gpg-exit 33554433


I've looked at the libzypp codebase on
https://github.com/openSUSE/libzypp.git, and it seems that verification
is happening in KeyManagerCtx::Impl::readSignaturesFprsOptVerify in
zypp/KeyManager.cc.

It looks to me like that private function declaration is:

std::list<std::string> readSignaturesFprsOptVerify( const Pathname & signature_r, const Pathname & file_r = "/dev/null", bool * verify_r = nullptr );

Note the default for file_r !

that's only called by two member functions:

/** Return all fingerprints found in \a signature_r. */
std::list<std::string> readSignaturesFprs( const Pathname & signature_r )
{ return readSignaturesFprsOptVerify( signature_r ); }

/** Tries to verify the \a file_r using \a signature_r. */
bool verifySignaturesFprs( const Pathname & file_r, const Pathname & signature_r )
{
bool verify = false;
readSignaturesFprsOptVerify( signature_r, file_r, &verify );
return verify;
}

which are in turn implementations of
KeyManagerCtx::readSignatureFingerprints and KeyManagerCtx::verify.


Is the failure happening for you in a call to
KeyManagerCtx::readSignatureFingerprints or in a call to
KeyManagerCtx::verify ? (or maybe KeyRing::readSignatureKeyId or
KeyRing::verifyFileSignature, which wrap those functions) ?

a backtrace of the code around the call to gpgme_op_verify would be
helpful.

Regards,

--dkg
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu, 2020-03-26 at 09:44 -0400, Daniel Kahn Gillmor wrote:
> On Thu 2020-03-19 08:25:03 -0700, James Bottomley via Gnupg-devel
> wrote:
> > On Thu, 2020-03-19 at 08:21 -0700, James Bottomley via Gnupg-devel
> > wrote:
> > > First reply is stuck in moderation. This has the compressed
> > > gpgme log
> >
> > I should add for the first reply that when I go in and run gpg
> > manually over exactly the directories and files the gpgme code is
> > using, verification succeeds, and when I try to do the same thing
> > using a test programme built on gpgme everything also succeeds, so
> > whatever is happening seems to be something to do with the sequence
> > of prior operations zypper did.
>
> Thanks for this log, James.

There are actually more details in the email that's stuck in moderation
if you can unstick it ... it's only about 40k over the list limit.

> From the log, there are 5 gpgme invocations: gpgme_op_import,
> gpgme_op_keylist, gpgme_op_import, gpgme_op_keylist, gpgme_op_verify.
>
> It looks to me like the failure is in the final call to
> gpgme_op_verify.
>
> In that call, gpgme is feeding the signature via fd 12 (0xc)
> successfully to the spawned gpg process's fd 11. This is correct,
> given the first non-option argument -&11. But it also needs to send
> the data via fd 14 (0xe) to gpg's fd 13, given the second non-option
> argument -&13.
>
> However it looks like it feeds it the empty string instead of any
> data that might have been signed:
>
> GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_data_outbound_handler:
> enter: dh=0x55aada91b5c0, fd=0xe
> GPGME 2020-03-19 08:19:04 <0x3839> gpgme_data_read: enter:
> dh=0x55aada91b5c0, buffer=0x55aada91b5cc, size=4096
> GPGME 2020-03-19 08:19:04 <0x3839> gpgme_data_read: leave:
> result=0
> GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_io_close: enter:
> fd=0xe
> GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_io_close: check:
> fd=0xe, invoking close handler 0x7f1e4272bfe0/0x55aadaa39aa0
> GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_remove_io_cb: call:
> data=0x55aada9ac5c0, setting fd 0xe (item=0x55aada8d2890) done
> GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_io_close: leave:
> result=0
> GPGME 2020-03-19 08:19:04 <0x3839> _gpgme_data_outbound_handler:
> leave
>
>
> Is it possible that the data object being passed to gpgme is
> corrupted somehow?

It must be ... and it's something to do with the sequence, not just
individual signatures. All the test cases I constructed so far using
exactly the same data as zypper pass just fine.

> Also, you say that zypper works if you revert this patch. have you
> tested this "working" configuration against a deliberately tampered
> message body? To test that it is working, it's best to verify both
> that a valid message is accepted *and* that a tampered message is
> rejected.

I can check ... I just have to set up a corrupt repo, hang on.

> This is gpg's status response, fwiw:
>
> [GNUPG:] PROGRESS -&11 ? 0 0 B
> [GNUPG:] PROGRESS -&11 ? 481 0 B
> [GNUPG:] PROGRESS -&13 ? 0 0 B
> [GNUPG:] NEWSIG
> [GNUPG:] KEY_CONSIDERED F17A9BC0C01F2AEE49F779EE668EA451E1B7CFAD 0
> [GNUPG:] KEY_CONSIDERED F17A9BC0C01F2AEE49F779EE668EA451E1B7CFAD 0
> [GNUPG:] BADSIG 668EA451E1B7CFAD home:jejb1:Tumbleweed OBS Project
> <home:jejb1:Tumbleweed@build.opensuse.org>
> [GNUPG:] VERIFICATION_COMPLIANCE_MODE 23
> [GNUPG] FAILURE gpg-exit 33554433
>
>
> I've looked at the libzypp codebase on
> https://github.com/openSUSE/libzypp.git, and it seems that
> verification
> is happening in KeyManagerCtx::Impl::readSignaturesFprsOptVerify in
> zypp/KeyManager.cc.
>
> It looks to me like that private function declaration is:
>
> std::list<std::string> readSignaturesFprsOptVerify( const
> Pathname & signature_r, const Pathname & file_r = "/dev/null", bool *
> verify_r = nullptr );
>
> Note the default for file_r !
>
> that's only called by two member functions:
>
> /** Return all fingerprints found in \a signature_r. */
> std::list<std::string> readSignaturesFprs( const Pathname &
> signature_r )
> { return readSignaturesFprsOptVerify( signature_r ); }
>
> /** Tries to verify the \a file_r using \a signature_r. */
> bool verifySignaturesFprs( const Pathname & file_r, const
> Pathname & signature_r )
> {
> bool verify = false;
> readSignaturesFprsOptVerify( signature_r, file_r, &verify );
> return verify;
> }
>
> which are in turn implementations of
> KeyManagerCtx::readSignatureFingerprints and KeyManagerCtx::verify.
>
>
> Is the failure happening for you in a call to
> KeyManagerCtx::readSignatureFingerprints or in a call to
> KeyManagerCtx::verify ? (or maybe KeyRing::readSignatureKeyId or
> KeyRing::verifyFileSignature, which wrap those functions) ?
>
> a backtrace of the code around the call to gpgme_op_verify would be
> helpful.

It's in the missing email ... if you can't free it from moderation, I
can break it up.

James
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu 2020-03-26 09:57:16 -0700, James Bottomley wrote:
> It's in the missing email ... if you can't free it from moderation, I
> can break it up.

I don't have any control over the mailing list, but feel free to send
me details privately if you like. or break up the pieces and send them
as individual messages to this thread. that seems a little silly, but
so it goes.

--dkg
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu, 26 Mar 2020 09:57, James Bottomley said:

> There are actually more details in the email that's stuck in moderation
> if you can unstick it ... it's only about 40k over the list limit.

Approved. Sorry, that I can't timely reply to your mails.


Shalom-Salam,

Werner

--
Die Gedanken sind frei. Ausnahmen regelt ein Bundesgesetz.
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu, 2020-03-26 at 09:57 -0700, James Bottomley via Gnupg-devel
wrote:
> On Thu, 2020-03-26 at 09:44 -0400, Daniel Kahn Gillmor wrote:
[...]
> > Also, you say that zypper works if you revert this patch. have you
> > tested this "working" configuration against a deliberately tampered
> > message body? To test that it is working, it's best to verify both
> > that a valid message is accepted *and* that a tampered message is
> > rejected.
>
> I can check ... I just have to set up a corrupt repo, hang on.

OK, I've created a repo under my control and pointed zypper to it and
verified it works OK. Corrupting the repomd.xml file to cause the
signature to fail gets a warning message from zypper and signing it
with a different key also gets a message asking me to accept the new
key, so I think its operating correctly with the patch reverted.

James
Re: [BUG REPORT] openSUSE zypper failure with all gpg versions > 2.2.6 [ In reply to ]
On Thu 2020-03-26 09:57:16 -0700, James Bottomley wrote:
>> a backtrace of the code around the call to gpgme_op_verify would be
>> helpful.
>
> It's in the missing email ... if you can't free it from moderation, I
> can break it up.

thanks Werner for releasing the message from moderation.

The relevant bits seem to be (i've tried to un-linewrap them, pls let me
know if i got it wrong):

2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(readSignatureKeyId):611 Determining key id of signature /var/cache/zypp/raw/jejb-tumbleweedSd4soS/repodata/repomd.xml.asc
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::gpg++] KeyManager.cc(createForOpenPGP):239 createForOpenPGP(/var/tmp/zypp.SwKyrE/PublicKey)
2020-03-19 08:08:14 <3> jarvis.int.hansenpartnership.com(13858) [zypp::gpg] KeyManager.cc(readSignaturesFprsOptVerify):174 <GnuPG> General error
2020-03-19 08:08:14 <1> jarvis.int.hansenpartnership.com(13858) [zypp::KeyRing] KeyRing.cc(verifyFileSignatureWorkflow):515 File [/var/tmp/AP_0xOFkuw6/repodata/repomd.xml] ( repomd.xml ) signed with unknown key []

So it is indeed failing during an attempt not to verify the signature,
but an attempt to verify the key IDs *in* the signature.

I can try to debug this in gpgme further, but i want to point out a
problem with the pattern that libzypp (or maybe zypper itself) is using
here.

the workflow seems to be:

- verify that <sig> contains a valid signature over <data>

- get a list of keys that are present in <sig>, and ensure that some
key is in a "known good" list.

(maybe not in that order -- it doesn't matter)

The risk is that <sig> could contain multiple signatures. Some of them
could be from the known-good list, and others not.

I don't have the time right now to try to attack zypper or libzypp right
now, to make sure that it's not vulnerable, but if i were responsible
for that tool, i'd want to audit it much more closely, and make a few
different test cases of attempted attacks, to make sure that they fail.

Feel free to contact me privately if you want to talk about this kind of
auditing/testing in a less public channel.

The better way to do the check you're trying to do is to get the list of
signing keys from the verification result itself. Do you see how this is
a security improvement?

As a side benefit, if you do this the way i describe above, you'll avoid
this extra attempt to get a list of key IDs from <sig> itself, which is
where the code is failing today.

These tools are still pretty clumsy and *way* too difficult to use
correctly, even for capable programmers like yourself. It's not your
fault for "holding it wrong" -- i'm just trying to help you think
through ways that you could do it better.

If you're interested thinking through simpler programmatic ways to do
what i think libzypper is trying to do (verify signature(s) that are
expected to come from one or more OpenPGP certificates in a curated
keyring), i'd welcome your feedback on
https://tools.ietf.org/html/draft-dkg-openpgp-stateless-cli.

Regards,

--dkg