[Qa-jenkins-scm] Build failed in Jenkins: reproducible_builder_i386_16 #20173

jenkins at jenkins.debian.net jenkins at jenkins.debian.net
Sat Oct 15 00:25:59 UTC 2016


https://jenkins.debian.net/job/reproducible_builder_i386_16/20173/------------------------------------------
[...truncated 2547 lines...]
+[Sat Oct 15 14:25:37 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000655s, 1526.718/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/condition/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Template "not_found.development.html.ep" not found
+[Sat Oct 15 14:25:37 2016] [debug] Template "not_found.html.ep" not found
+[Sat Oct 15 14:25:37 2016] [debug] Rendering template "mojo/debug.html.ep"
+[Sat Oct 15 14:25:37 2016] [debug] Rendering template "mojo/menubar.html.ep"
+[Sat Oct 15 14:25:37 2016] [debug] 404 Not Found (0.035772s, 27.955/s)
+[Sat Oct 15 14:25:37 2016] [debug] POST "/login"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000665s, 1503.759/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000573s, 1745.201/s)
+[Sat Oct 15 14:25:37 2016] [debug] POST "/login"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000902s, 1108.647/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000605s, 1652.893/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/condition/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000578s, 1730.104/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/logout"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000614s, 1628.664/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000559s, 1788.909/s)
+[Sat Oct 15 14:25:37 2016] [debug] POST "/login2"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000714s, 1400.560/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000539s, 1855.288/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/condition/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:37 2016] [debug] 200 OK (0.000652s, 1533.742/s)
+[Sat Oct 15 14:25:37 2016] [debug] GET "/condition/authonly"
+[Sat Oct 15 14:25:37 2016] [debug] 401 Unauthorized (0.000591s, 1692.047/s)
 t/01-functional.t ......... 
 1..41
 ok 1 - GET /
@@ -384,49 +395,49 @@
 ok 40 - 401 Unauthorized
 ok 41 - exact match for JSON Pointer "/message"
 ok
-[Thu Nov 16 18:47:13 2017] [debug] GET "/"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.00028s, 3571.429/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/authonly/lazy"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] Your secret passphrase needs to be changed
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000379s, 2638.522/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/condition/authonly/lazy"
-[Thu Nov 16 18:47:13 2017] [debug] Template "not_found.development.html.ep" not found
-[Thu Nov 16 18:47:13 2017] [debug] Template "not_found.html.ep" not found
-[Thu Nov 16 18:47:13 2017] [debug] Rendering template "mojo/debug.html.ep"
-[Thu Nov 16 18:47:13 2017] [debug] Rendering template "mojo/menubar.html.ep"
-[Thu Nov 16 18:47:13 2017] [debug] 404 Not Found (0.016027s, 62.395/s)
-[Thu Nov 16 18:47:13 2017] [debug] POST "/login"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000287s, 3484.321/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/authonly"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000243s, 4115.226/s)
-[Thu Nov 16 18:47:13 2017] [debug] POST "/login"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000315s, 3174.603/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/authonly"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000333s, 3003.003/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/condition/authonly"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000338s, 2958.580/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/authonly/lazy"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000324s, 3086.420/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/condition/authonly/lazy"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000335s, 2985.075/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/logout"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000332s, 3012.048/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/authonly"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000306s, 3267.974/s)
-[Thu Nov 16 18:47:13 2017] [debug] GET "/authonly/lazy"
-[Thu Nov 16 18:47:13 2017] [debug] Routing to a callback
-[Thu Nov 16 18:47:13 2017] [debug] 200 OK (0.000313s, 3194.888/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000735s, 1360.544/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/authonly/lazy"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] Your secret passphrase needs to be changed
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000958s, 1043.841/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/condition/authonly/lazy"
+[Sat Oct 15 14:25:38 2016] [debug] Template "not_found.development.html.ep" not found
+[Sat Oct 15 14:25:38 2016] [debug] Template "not_found.html.ep" not found
+[Sat Oct 15 14:25:38 2016] [debug] Rendering template "mojo/debug.html.ep"
+[Sat Oct 15 14:25:38 2016] [debug] Rendering template "mojo/menubar.html.ep"
+[Sat Oct 15 14:25:38 2016] [debug] 404 Not Found (0.040471s, 24.709/s)
+[Sat Oct 15 14:25:38 2016] [debug] POST "/login"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000763s, 1310.616/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000599s, 1669.449/s)
+[Sat Oct 15 14:25:38 2016] [debug] POST "/login"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000782s, 1278.772/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000892s, 1121.076/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/condition/authonly"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000916s, 1091.703/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/authonly/lazy"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000791s, 1264.223/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/condition/authonly/lazy"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.00082s, 1219.512/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/logout"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000853s, 1172.333/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/authonly"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000753s, 1328.021/s)
+[Sat Oct 15 14:25:38 2016] [debug] GET "/authonly/lazy"
+[Sat Oct 15 14:25:38 2016] [debug] Routing to a callback
+[Sat Oct 15 14:25:38 2016] [debug] 200 OK (0.000698s, 1432.665/s)
 t/02-functional_lazy.t .... 
 1..38
 ok 1 - GET /
@@ -471,25 +482,25 @@
 t/manifest.t .............. skipped: Author tests not required for installation
 t/release-cpan-changes.t .. skipped: these tests are for release candidate testing
 All tests successful.
-Files=5, Tests=80,  0 wallclock secs ( 0.02 usr  0.00 sys +  0.42 cusr  0.02 csys =  0.46 CPU)
+Files=5, Tests=80,  2 wallclock secs ( 0.07 usr  0.01 sys +  1.22 cusr  0.08 csys =  1.38 CPU)
 Result: PASS
-make[1]: Leaving directory '/build/libmojolicious-plugin-authentication-perl-1.29'
+make[1]: Verzeichnis „/build/libmojolicious-plugin-authentication-perl-1.29“ wird verlassen
  fakeroot debian/rules binary
 dh binary
    dh_testroot
    dh_prep
    debian/rules override_dh_auto_install
-make[1]: Entering directory '/build/libmojolicious-plugin-authentication-perl-1.29'
+make[1]: Verzeichnis „/build/libmojolicious-plugin-authentication-perl-1.29“ wird betreten
 dh_auto_install
 	make -j1 install DESTDIR=/build/libmojolicious-plugin-authentication-perl-1.29/debian/libmojolicious-plugin-authentication-perl AM_UPDATE_INFO_DIR=no PREFIX=/usr
-make[2]: Entering directory '/build/libmojolicious-plugin-authentication-perl-1.29'
+make[2]: Verzeichnis „/build/libmojolicious-plugin-authentication-perl-1.29“ wird betreten
 Manifying 1 pod document
 Installing /build/libmojolicious-plugin-authentication-perl-1.29/debian/libmojolicious-plugin-authentication-perl/usr/share/perl5/Mojolicious/Plugin/Authentication.pm
 Installing /build/libmojolicious-plugin-authentication-perl-1.29/debian/libmojolicious-plugin-authentication-perl/usr/share/man/man3/Mojolicious::Plugin::Authentication.3pm
-make[2]: Leaving directory '/build/libmojolicious-plugin-authentication-perl-1.29'
+make[2]: Verzeichnis „/build/libmojolicious-plugin-authentication-perl-1.29“ wird verlassen
 rm -f -v /build/libmojolicious-plugin-authentication-perl-1.29/debian/libmojolicious-plugin-authentication-perl/usr/share/man/man3/Mojolicious::Plugin::README.3pm \
 	/build/libmojolicious-plugin-authentication-perl-1.29/debian/libmojolicious-plugin-authentication-perl/usr/share/perl5/Mojolicious/Plugin/README.pod
-make[1]: Leaving directory '/build/libmojolicious-plugin-authentication-perl-1.29'
+make[1]: Verzeichnis „/build/libmojolicious-plugin-authentication-perl-1.29“ wird verlassen
    dh_installdocs
    dh_installchangelogs
    dh_installman
@@ -503,7 +514,7 @@
 dpkg-gencontrol: warning: File::FcntlLock not available; using flock which is not NFS-safe
    dh_md5sums
    dh_builddeb
-dpkg-deb: building package 'libmojolicious-plugin-authentication-perl' in '../libmojolicious-plugin-authentication-perl_1.29-1_all.deb'.
+dpkg-deb: Paket »libmojolicious-plugin-authentication-perl« wird in »../libmojolicious-plugin-authentication-perl_1.29-1_all.deb« gebaut.
  dpkg-genbuildinfo --build=any,all --buildinfo-id=i386
 dpkg-genbuildinfo: warning: File::FcntlLock not available; using flock which is not NFS-safe
  dpkg-genchanges --build=any,all >../libmojolicious-plugin-authentication-perl_1.29-1_i386.changes
@@ -511,12 +522,14 @@
  dpkg-source --after-build libmojolicious-plugin-authentication-perl-1.29
 dpkg-buildpackage: info: binary-only upload (no source included)
 I: copying local configuration
+I: user script /srv/workspace/pbuilder/23311/tmp/hooks/B01_cleanup starting
+I: user script /srv/workspace/pbuilder/23311/tmp/hooks/B01_cleanup finished
 I: unmounting /dev/shm filesystem
 I: unmounting dev/pts filesystem
 I: unmounting run/shm filesystem
 I: unmounting proc filesystem
 I: unmounting sys filesystem
 I: cleaning the build env 
-I: removing directory /srv/workspace/pbuilder/64475 and its subdirectories
-I: Current time: Thu Nov 16 18:47:15 GMT+12 2017
-I: pbuilder-time-stamp: 1510901235
+I: removing directory /srv/workspace/pbuilder/23311 and its subdirectories
+I: Current time: Sam Okt 15 14:25:54 GMT-14 2016
+I: pbuilder-time-stamp: 1476491154

Compressing the 2nd log...
/var/lib/jenkins/userContent/reproducible/debian/logdiffs/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.diff:	 83.2% -- replaced with /var/lib/jenkins/userContent/reproducible/debian/logdiffs/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.diff.gz
b2/build.log:	 79.3%
+ echo 'Compressing the 1st log...'
Compressing the 1st log...
+ gzip -9cvn b1/build.log
b1/build.log:	 79.7%
+ chmod 644 /var/lib/jenkins/userContent/reproducible/debian/logs/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.build1.log.gz
+ update_rbuildlog
+ chmod 644 /srv/reproducible-results/rbuild-debian-KLWBDhbL/tmp.UwypIbnOz2
+ mv /srv/reproducible-results/rbuild-debian-KLWBDhbL/tmp.UwypIbnOz2 /var/lib/jenkins/userContent/reproducible/debian/rbuild/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.rbuild.log
+ RBUILDLOG=/var/lib/jenkins/userContent/reproducible/debian/rbuild/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.rbuild.log
+ '[' 0 -eq 1 ']'
+ '[' 0 -eq 0 ']'
+ call_diffoscope_on_buildinfo_files
++ mktemp --tmpdir=/srv/reproducible-results/rbuild-debian-KLWBDhbL
+ local TMPLOG=/srv/reproducible-results/rbuild-debian-KLWBDhbL/tmp.eLpONydSxW
+ local TIMEOUT=120m
+ DBDSUITE=testing
+ '[' testing = experimental ']'
+ set -x
++ mktemp --tmpdir=/srv/reproducible-results/rbuild-debian-KLWBDhbL -d dbd-tmp-XXXXXXX
+ local TEMP=/srv/reproducible-results/rbuild-debian-KLWBDhbL/dbd-tmp-AjeODEQ
++ schroot --directory /srv/reproducible-results/rbuild-debian-KLWBDhbL -c source:jenkins-reproducible-testing-diffoscope diffoscope -- --version
+ DIFFOSCOPE='diffoscope 61'
++ echo diffoscope 61
++ grep '^E: 15binfmt: update-binfmts: unable to open'
++ true
+ LOG_RESULT=
+ '[' '!' -z '' ']'
+ log_info 'diffoscope 61 will be used to compare the two builds:'
+ _log I: 'diffoscope 61 will be used to compare the two builds:'
+ local prefix=I:
+ shift 1
+ tee -a /var/lib/jenkins/userContent/reproducible/debian/rbuild/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.rbuild.log
++ date -u
+ echo -e 'Sat Oct 15 00:25:57 UTC 2016  I: diffoscope 61 will be used to compare the two builds:'
Sat Oct 15 00:25:57 UTC 2016  I: diffoscope 61 will be used to compare the two builds:
+ set +e
+ set -x
+ timeout 120m nice schroot --directory /srv/reproducible-results/rbuild-debian-KLWBDhbL -c source:jenkins-reproducible-testing-diffoscope -- sh -c 'export TMPDIR=/srv/reproducible-results/rbuild-debian-KLWBDhbL/dbd-tmp-AjeODEQ ; diffoscope 			--html /srv/reproducible-results/rbuild-debian-KLWBDhbL/libmojolicious-plugin-authentication-perl_1.29-1.diffoscope.html 			--text /srv/reproducible-results/rbuild-debian-KLWBDhbL/libmojolicious-plugin-authentication-perl_1.29-1.diffoscope.txt 			/srv/reproducible-results/rbuild-debian-KLWBDhbL/b1/libmojolicious-plugin-authentication-perl_1.29-1_i386.buildinfo 			/srv/reproducible-results/rbuild-debian-KLWBDhbL/b2/libmojolicious-plugin-authentication-perl_1.29-1_i386.buildinfo'
+ RESULT=0
++ grep '^E: 15binfmt: update-binfmts: unable to open' /srv/reproducible-results/rbuild-debian-KLWBDhbL/tmp.eLpONydSxW
++ true
+ LOG_RESULT=
+ '[' '!' -z '' ']'
+ false
+ set +x
/var/lib/jenkins/userContent/reproducible/debian/rbuild/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.rbuild.log:	
gzip: /var/lib/jenkins/userContent/reproducible/debian/rbuild/testing/i386/libmojolicious-plugin-authentication-perl_1.29-1.rbuild.log.gz: No space left on device
Sat 15 Oct 00:25:59 UTC 2016 - /srv/jenkins/bin/reproducible_build.sh stopped running as /tmp/jenkins-script-hd9ymCwQ, which will now be removed.
Build step 'Execute shell' marked build as failure



More information about the Qa-jenkins-scm mailing list