[Qa-jenkins-scm] Build failed in Jenkins: reproducible_builder_i386_10 #33394

Mon Feb 6 06:22:50 UTC 2017

https://jenkins.debian.net/job/reproducible_builder_i386_10/33394/------------------------------------------
[...truncated 466.60 KB...]
[Sun Mar 11 00:45:29.149194 2018] [proxy:debug] [pid 45331:tid 4147848960] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local
[Sun Mar 11 00:45:29.149216 2018] [proxy:debug] [pid 45331:tid 4147848960] proxy_util.c(1856): AH00930: initialized pool in child 45331 for (*) min=0 max=25 smax=25
[Sun Mar 11 00:45:29.149221 2018] [proxy:debug] [pid 45331:tid 4147848960] proxy_util.c(1779): AH00925: initializing worker https://localhost:9934/ shared
[Sun Mar 11 00:45:29.149226 2018] [proxy:debug] [pid 45331:tid 4147848960] proxy_util.c(1821): AH00927: initializing worker https://localhost:9934/ local
[Sun Mar 11 00:45:29.149232 2018] [proxy:debug] [pid 45331:tid 4147848960] proxy_util.c(1856): AH00930: initialized pool in child 45331 for (localhost) min=0 max=25 smax=25
[Sun Mar 11 00:45:29.149247 2018] [mpm_worker:notice] [pid 45322:tid 4147848960] AH00292: Apache/2.4.25 (Debian) mod_gnutls/0.8.2 GnuTLS/3.5.8 configured -- resuming normal operations
[Sun Mar 11 00:45:29.149258 2018] [mpm_worker:info] [pid 45322:tid 4147848960] AH00293: Server built: 2017-01-25T22:59:26
[Sun Mar 11 00:45:29.149264 2018] [core:notice] [pid 45322:tid 4147848960] AH00094: Command line: '/usr/sbin/apache2 -f /build/1st/mod-gnutls-0.8.2/test/tests/22_TLS_reverse_proxy_crl_revoke/apache.conf'
[Sun Mar 11 00:45:29.149267 2018] [core:debug] [pid 45322:tid 4147848960] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1)
[Sun Mar 11 00:45:29.149274 2018] [mpm_worker:debug] [pid 45322:tid 4147848960] worker.c(1885): AH00294: Accept mutex: sysvsem (default: sysvsem)
[Sun Mar 11 00:45:29.149334 2018] [watchdog:debug] [pid 45338:tid 4147848960] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:29.149380 2018] [proxy:debug] [pid 45338:tid 4147848960] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared
[Sun Mar 11 00:45:29.149385 2018] [proxy:debug] [pid 45338:tid 4147848960] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local
[Sun Mar 11 00:45:29.149405 2018] [proxy:debug] [pid 45338:tid 4147848960] proxy_util.c(1856): AH00930: initialized pool in child 45338 for (*) min=0 max=25 smax=25
[Sun Mar 11 00:45:29.149409 2018] [proxy:debug] [pid 45338:tid 4147848960] proxy_util.c(1779): AH00925: initializing worker https://localhost:9934/ shared
[Sun Mar 11 00:45:29.149414 2018] [proxy:debug] [pid 45338:tid 4147848960] proxy_util.c(1821): AH00927: initializing worker https://localhost:9934/ local
[Sun Mar 11 00:45:29.149420 2018] [proxy:debug] [pid 45338:tid 4147848960] proxy_util.c(1856): AH00930: initialized pool in child 45338 for (localhost) min=0 max=25 smax=25
[Sun Mar 11 00:45:29.191781 2018] [gnutls:debug] [pid 45330:tid 4122999616] gnutls_cache.c(445): Cleaned up cache '/build/1st/mod-gnutls-0.8.2/test/cache/gnutls_cache'. Deleted 0 and left 22
[Sun Mar 11 00:45:29.199987 2018] [gnutls:debug] [pid 45330:tid 4122999616] gnutls_io.c(547): [client ::1:42465] mgs_filter_input: TLS connection opened.
[Sun Mar 11 00:45:29.200028 2018] [authz_core:debug] [pid 45330:tid 4122999616] mod_authz_core.c(835): [client ::1:42465] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:29.200159 2018] [proxy:debug] [pid 45330:tid 4122999616] mod_proxy.c(1228): [client ::1:42465] AH01143: Running scheme https handler (attempt 0)
[Sun Mar 11 00:45:29.200173 2018] [proxy:debug] [pid 45330:tid 4122999616] proxy_util.c(2156): AH00942: HTTPS: has acquired connection for (localhost)
[Sun Mar 11 00:45:29.200178 2018] [proxy:debug] [pid 45330:tid 4122999616] proxy_util.c(2209): [client ::1:42465] AH00944: connecting https://localhost:9934/test.txt to localhost:9934
[Sun Mar 11 00:45:29.200252 2018] [proxy:debug] [pid 45330:tid 4122999616] proxy_util.c(2418): [client ::1:42465] AH00947: connected /test.txt to localhost:9934
[Sun Mar 11 00:45:29.200288 2018] [proxy:debug] [pid 45330:tid 4122999616] proxy_util.c(2884): AH02824: HTTPS: connection established with [::1]:9934 (localhost)
[Sun Mar 11 00:45:29.200311 2018] [proxy:debug] [pid 45330:tid 4122999616] proxy_util.c(3051): AH00962: HTTPS: connection complete to [::1]:9934 (localhost)
[Sun Mar 11 00:45:29.220757 2018] [gnutls:warn] [pid 45330:tid 4122999616] [remote ::1:9934] gtls_check_server_cert: The certificate is NOT trusted. The certificate chain is revoked. 
[Sun Mar 11 00:45:29.220771 2018] [gnutls:info] [pid 45330:tid 4122999616] [remote ::1:9934] GnuTLS: Handshake Failed (-43) 'Error in the certificate.'
[Sun Mar 11 00:45:29.220821 2018] [gnutls:debug] [pid 45330:tid 4122999616] gnutls_io.c(552): [remote ::1:9934] mgs_filter_input proxy : ap_get_brigade
[Sun Mar 11 00:45:29.220841 2018] [proxy_http:error] [pid 45330:tid 4122999616] (22)Invalid argument: [client ::1:42465] AH01102: error reading status line from remote server localhost:9934
[Sun Mar 11 00:45:29.220851 2018] [proxy_http:debug] [pid 45330:tid 4122999616] mod_proxy_http.c(1324): [client ::1:42465] AH01105: NOT Closing connection to client although reading from backend server localhost:9934 failed.
[Sun Mar 11 00:45:29.220857 2018] [proxy:error] [pid 45330:tid 4122999616] [client ::1:42465] AH00898: Error reading from remote server returned by /proxy/test.txt
[Sun Mar 11 00:45:29.220860 2018] [proxy:debug] [pid 45330:tid 4122999616] proxy_util.c(2171): AH00943: HTTPS: has released connection for (localhost)
[Sun Mar 11 00:45:29.220976 2018] [gnutls:debug] [pid 45330:tid 4122999616] gnutls_io.c(513): [client ::1:42465] mgs_bye: TLS connection closed.
[Sun Mar 11 00:45:30.609813 2018] [core:info] [pid 45322:tid 4147848960] AH00096: removed PID file /build/1st/mod-gnutls-0.8.2/test/apache2.pid (pid=45322)
[Sun Mar 11 00:45:30.609850 2018] [mpm_worker:notice] [pid 45322:tid 4147848960] AH00295: caught SIGTERM, shutting down
=======
test/logs/23_TLS_reverse_proxy_mismatched_priorities.backend.error.log
[Sun Mar 11 00:45:30.699020 2018] [watchdog:debug] [pid 45469:tid 4147730176] mod_watchdog.c(460): AH02974: Watchdog: found parent providers.
[Sun Mar 11 00:45:30.699053 2018] [watchdog:debug] [pid 45469:tid 4147730176] mod_watchdog.c(506): AH02977: Watchdog: found child providers.
[Sun Mar 11 00:45:30.699057 2018] [watchdog:debug] [pid 45469:tid 4147730176] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_singleton_).
[Sun Mar 11 00:45:30.699060 2018] [watchdog:debug] [pid 45469:tid 4147730176] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_default_).
[Sun Mar 11 00:45:30.700053 2018] [watchdog:debug] [pid 45472:tid 4147730176] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:30.700235 2018] [watchdog:debug] [pid 45473:tid 4147730176] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:30.700377 2018] [mpm_worker:notice] [pid 45469:tid 4147730176] AH00292: Apache/2.4.25 (Debian) mod_gnutls/0.8.2 GnuTLS/3.5.8 configured -- resuming normal operations
[Sun Mar 11 00:45:30.700391 2018] [mpm_worker:info] [pid 45469:tid 4147730176] AH00293: Server built: 2017-01-25T22:59:26
[Sun Mar 11 00:45:30.700400 2018] [core:notice] [pid 45469:tid 4147730176] AH00094: Command line: '/usr/sbin/apache2 -f /build/1st/mod-gnutls-0.8.2/test/tests/23_TLS_reverse_proxy_mismatched_priorities/backend.conf'
[Sun Mar 11 00:45:30.700405 2018] [core:debug] [pid 45469:tid 4147730176] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1)
[Sun Mar 11 00:45:30.700414 2018] [mpm_worker:debug] [pid 45469:tid 4147730176] worker.c(1885): AH00294: Accept mutex: sysvsem (default: sysvsem)
[Sun Mar 11 00:45:30.700457 2018] [watchdog:debug] [pid 45485:tid 4147730176] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:30.810671 2018] [gnutls:info] [pid 45472:tid 4122999616] [client ::1:57634] GnuTLS: Handshake Failed (-8) 'A packet with illegal or unsupported version was received.'
[Sun Mar 11 00:45:30.810704 2018] [gnutls:debug] [pid 45472:tid 4122999616] gnutls_io.c(552): [client ::1:57634] mgs_filter_input : ap_get_brigade
[Sun Mar 11 00:45:30.810725 2018] [core:debug] [pid 45472:tid 4122999616] protocol.c(820): [client ::1:57634] AH03445: HTTP Request Line; Invalid method token: '\x02FGET'
=======
test/logs/23_TLS_reverse_proxy_mismatched_priorities.error.log
[Sun Mar 11 00:45:30.729841 2018] [gnutls:info] [pid 45562:tid 4148070144] load_proxy_x509_credentials: no client credentials for proxy
[Sun Mar 11 00:45:30.729954 2018] [gnutls:debug] [pid 45562:tid 4148070144] gnutls_hooks.c(2011): load_proxy_x509_credentials: proxy CA trust list: 1 structures loaded
[Sun Mar 11 00:45:30.739617 2018] [watchdog:debug] [pid 45563:tid 4148070144] mod_watchdog.c(460): AH02974: Watchdog: found parent providers.
[Sun Mar 11 00:45:30.739632 2018] [watchdog:debug] [pid 45563:tid 4148070144] mod_watchdog.c(506): AH02977: Watchdog: found child providers.
[Sun Mar 11 00:45:30.739637 2018] [watchdog:debug] [pid 45563:tid 4148070144] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_singleton_).
[Sun Mar 11 00:45:30.739641 2018] [watchdog:debug] [pid 45563:tid 4148070144] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_default_).
[Sun Mar 11 00:45:30.740398 2018] [gnutls:info] [pid 45563:tid 4148070144] load_proxy_x509_credentials: no client credentials for proxy
[Sun Mar 11 00:45:30.740531 2018] [gnutls:debug] [pid 45563:tid 4148070144] gnutls_hooks.c(2011): load_proxy_x509_credentials: proxy CA trust list: 1 structures loaded
[Sun Mar 11 00:45:30.741033 2018] [watchdog:debug] [pid 45571:tid 4148070144] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:30.741087 2018] [proxy:debug] [pid 45571:tid 4148070144] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared
[Sun Mar 11 00:45:30.741092 2018] [proxy:debug] [pid 45571:tid 4148070144] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local
[Sun Mar 11 00:45:30.741118 2018] [proxy:debug] [pid 45571:tid 4148070144] proxy_util.c(1856): AH00930: initialized pool in child 45571 for (*) min=0 max=25 smax=25
[Sun Mar 11 00:45:30.741122 2018] [proxy:debug] [pid 45571:tid 4148070144] proxy_util.c(1779): AH00925: initializing worker https://localhost:9934/ shared
[Sun Mar 11 00:45:30.741128 2018] [proxy:debug] [pid 45571:tid 4148070144] proxy_util.c(1821): AH00927: initializing worker https://localhost:9934/ local
[Sun Mar 11 00:45:30.741135 2018] [proxy:debug] [pid 45571:tid 4148070144] proxy_util.c(1856): AH00930: initialized pool in child 45571 for (localhost) min=0 max=25 smax=25
[Sun Mar 11 00:45:30.741325 2018] [watchdog:debug] [pid 45572:tid 4148070144] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:30.741388 2018] [proxy:debug] [pid 45572:tid 4148070144] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared
[Sun Mar 11 00:45:30.741396 2018] [proxy:debug] [pid 45572:tid 4148070144] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local
[Sun Mar 11 00:45:30.741424 2018] [proxy:debug] [pid 45572:tid 4148070144] proxy_util.c(1856): AH00930: initialized pool in child 45572 for (*) min=0 max=25 smax=25
[Sun Mar 11 00:45:30.741431 2018] [proxy:debug] [pid 45572:tid 4148070144] proxy_util.c(1779): AH00925: initializing worker https://localhost:9934/ shared
[Sun Mar 11 00:45:30.741438 2018] [proxy:debug] [pid 45572:tid 4148070144] proxy_util.c(1821): AH00927: initializing worker https://localhost:9934/ local
[Sun Mar 11 00:45:30.741447 2018] [proxy:debug] [pid 45572:tid 4148070144] proxy_util.c(1856): AH00930: initialized pool in child 45572 for (localhost) min=0 max=25 smax=25
[Sun Mar 11 00:45:30.741480 2018] [mpm_worker:notice] [pid 45563:tid 4148070144] AH00292: Apache/2.4.25 (Debian) mod_gnutls/0.8.2 GnuTLS/3.5.8 configured -- resuming normal operations
[Sun Mar 11 00:45:30.741492 2018] [mpm_worker:info] [pid 45563:tid 4148070144] AH00293: Server built: 2017-01-25T22:59:26
[Sun Mar 11 00:45:30.741498 2018] [core:notice] [pid 45563:tid 4148070144] AH00094: Command line: '/usr/sbin/apache2 -f /build/1st/mod-gnutls-0.8.2/test/tests/23_TLS_reverse_proxy_mismatched_priorities/apache.conf'
[Sun Mar 11 00:45:30.741501 2018] [core:debug] [pid 45563:tid 4148070144] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1)
[Sun Mar 11 00:45:30.741508 2018] [mpm_worker:debug] [pid 45563:tid 4148070144] worker.c(1885): AH00294: Accept mutex: sysvsem (default: sysvsem)
[Sun Mar 11 00:45:30.741572 2018] [watchdog:debug] [pid 45586:tid 4148070144] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:30.741617 2018] [proxy:debug] [pid 45586:tid 4148070144] proxy_util.c(1779): AH00925: initializing worker proxy:reverse shared
[Sun Mar 11 00:45:30.741622 2018] [proxy:debug] [pid 45586:tid 4148070144] proxy_util.c(1821): AH00927: initializing worker proxy:reverse local
[Sun Mar 11 00:45:30.741644 2018] [proxy:debug] [pid 45586:tid 4148070144] proxy_util.c(1856): AH00930: initialized pool in child 45586 for (*) min=0 max=25 smax=25
[Sun Mar 11 00:45:30.741647 2018] [proxy:debug] [pid 45586:tid 4148070144] proxy_util.c(1779): AH00925: initializing worker https://localhost:9934/ shared
[Sun Mar 11 00:45:30.741652 2018] [proxy:debug] [pid 45586:tid 4148070144] proxy_util.c(1821): AH00927: initializing worker https://localhost:9934/ local
[Sun Mar 11 00:45:30.741658 2018] [proxy:debug] [pid 45586:tid 4148070144] proxy_util.c(1856): AH00930: initialized pool in child 45586 for (localhost) min=0 max=25 smax=25
[Sun Mar 11 00:45:30.767810 2018] [gnutls:debug] [pid 45571:tid 4122999616] gnutls_cache.c(445): Cleaned up cache '/build/1st/mod-gnutls-0.8.2/test/cache/gnutls_cache'. Deleted 0 and left 23
[Sun Mar 11 00:45:30.790439 2018] [gnutls:debug] [pid 45571:tid 4122999616] gnutls_io.c(547): [client ::1:42467] mgs_filter_input: TLS connection opened.
[Sun Mar 11 00:45:30.790488 2018] [authz_core:debug] [pid 45571:tid 4122999616] mod_authz_core.c(835): [client ::1:42467] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:30.790625 2018] [proxy:debug] [pid 45571:tid 4122999616] mod_proxy.c(1228): [client ::1:42467] AH01143: Running scheme https handler (attempt 0)
[Sun Mar 11 00:45:30.790641 2018] [proxy:debug] [pid 45571:tid 4122999616] proxy_util.c(2156): AH00942: HTTPS: has acquired connection for (localhost)
[Sun Mar 11 00:45:30.790646 2018] [proxy:debug] [pid 45571:tid 4122999616] proxy_util.c(2209): [client ::1:42467] AH00944: connecting https://localhost:9934/test.txt to localhost:9934
[Sun Mar 11 00:45:30.790747 2018] [proxy:debug] [pid 45571:tid 4122999616] proxy_util.c(2418): [client ::1:42467] AH00947: connected /test.txt to localhost:9934
[Sun Mar 11 00:45:30.790802 2018] [proxy:debug] [pid 45571:tid 4122999616] proxy_util.c(2884): AH02824: HTTPS: connection established with [::1]:9934 (localhost)
[Sun Mar 11 00:45:30.790832 2018] [proxy:debug] [pid 45571:tid 4122999616] proxy_util.c(3051): AH00962: HTTPS: connection complete to [::1]:9934 (localhost)
[Sun Mar 11 00:45:30.810616 2018] [gnutls:info] [pid 45571:tid 4122999616] [remote ::1:9934] GnuTLS: Handshake Failed (-8) 'A packet with illegal or unsupported version was received.'
[Sun Mar 11 00:45:30.810677 2018] [gnutls:debug] [pid 45571:tid 4122999616] gnutls_io.c(552): [remote ::1:9934] mgs_filter_input proxy : ap_get_brigade
[Sun Mar 11 00:45:30.810685 2018] [proxy_http:error] [pid 45571:tid 4122999616] (22)Invalid argument: [client ::1:42467] AH01102: error reading status line from remote server localhost:9934
[Sun Mar 11 00:45:30.810696 2018] [proxy_http:debug] [pid 45571:tid 4122999616] mod_proxy_http.c(1324): [client ::1:42467] AH01105: NOT Closing connection to client although reading from backend server localhost:9934 failed.
[Sun Mar 11 00:45:30.810702 2018] [proxy:error] [pid 45571:tid 4122999616] [client ::1:42467] AH00898: Error reading from remote server returned by /proxy/test.txt
[Sun Mar 11 00:45:30.810706 2018] [proxy:debug] [pid 45571:tid 4122999616] proxy_util.c(2171): AH00943: HTTPS: has released connection for (localhost)
[Sun Mar 11 00:45:30.810858 2018] [gnutls:debug] [pid 45571:tid 4122999616] gnutls_io.c(513): [client ::1:42467] mgs_bye: TLS connection closed.
=======
test/logs/24_pkcs11_cert.error.log
[Sun Mar 11 00:45:06.493240 2018] [watchdog:debug] [pid 41081:tid 4147963648] mod_watchdog.c(460): AH02974: Watchdog: found parent providers.
[Sun Mar 11 00:45:06.493263 2018] [watchdog:debug] [pid 41081:tid 4147963648] mod_watchdog.c(506): AH02977: Watchdog: found child providers.
[Sun Mar 11 00:45:06.493266 2018] [watchdog:debug] [pid 41081:tid 4147963648] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_singleton_).
[Sun Mar 11 00:45:06.493269 2018] [watchdog:debug] [pid 41081:tid 4147963648] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_default_).
[Sun Mar 11 00:45:06.496906 2018] [watchdog:debug] [pid 41089:tid 4147963648] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:06.497126 2018] [watchdog:debug] [pid 41090:tid 4147963648] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:06.497297 2018] [mpm_worker:notice] [pid 41081:tid 4147963648] AH00292: Apache/2.4.25 (Debian) mod_gnutls/0.8.2 GnuTLS/3.5.8 configured -- resuming normal operations
[Sun Mar 11 00:45:06.497308 2018] [mpm_worker:info] [pid 41081:tid 4147963648] AH00293: Server built: 2017-01-25T22:59:26
[Sun Mar 11 00:45:06.497315 2018] [core:notice] [pid 41081:tid 4147963648] AH00094: Command line: '/usr/sbin/apache2 -f /build/1st/mod-gnutls-0.8.2/test/tests/24_pkcs11_cert/apache.conf'
[Sun Mar 11 00:45:06.497318 2018] [core:debug] [pid 41081:tid 4147963648] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1)
[Sun Mar 11 00:45:06.497325 2018] [mpm_worker:debug] [pid 41081:tid 4147963648] worker.c(1885): AH00294: Accept mutex: sysvsem (default: sysvsem)
[Sun Mar 11 00:45:06.497379 2018] [watchdog:debug] [pid 41091:tid 4147963648] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:06.526448 2018] [gnutls:debug] [pid 41090:tid 4116708160] gnutls_cache.c(445): Cleaned up cache '/build/1st/mod-gnutls-0.8.2/test/cache/gnutls_cache'. Deleted 0 and left 7
[Sun Mar 11 00:45:06.529226 2018] [gnutls:debug] [pid 41090:tid 4116708160] gnutls_io.c(547): [client ::1:42442] mgs_filter_input: TLS connection opened.
[Sun Mar 11 00:45:06.529304 2018] [authz_core:debug] [pid 41090:tid 4116708160] mod_authz_core.c(835): [client ::1:42442] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:06.529568 2018] [gnutls:debug] [pid 41090:tid 4116708160] gnutls_io.c(513): [client ::1:42442] mgs_bye: TLS connection closed.
[Sun Mar 11 00:45:07.920774 2018] [core:info] [pid 41081:tid 4147963648] AH00096: removed PID file /build/1st/mod-gnutls-0.8.2/test/apache2.pid (pid=41081)
[Sun Mar 11 00:45:07.920804 2018] [mpm_worker:notice] [pid 41081:tid 4147963648] AH00295: caught SIGTERM, shutting down
=======
test/logs/25_Disable_TLS_1.0.error.log
[Sun Mar 11 00:45:07.967725 2018] [watchdog:debug] [pid 41200:tid 4147189504] mod_watchdog.c(460): AH02974: Watchdog: found parent providers.
[Sun Mar 11 00:45:07.967765 2018] [watchdog:debug] [pid 41200:tid 4147189504] mod_watchdog.c(506): AH02977: Watchdog: found child providers.
[Sun Mar 11 00:45:07.967769 2018] [watchdog:debug] [pid 41200:tid 4147189504] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_default_).
[Sun Mar 11 00:45:07.967772 2018] [watchdog:debug] [pid 41200:tid 4147189504] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_singleton_).
[Sun Mar 11 00:45:07.968769 2018] [watchdog:debug] [pid 41208:tid 4147189504] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:07.968970 2018] [watchdog:debug] [pid 41210:tid 4147189504] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:07.969129 2018] [mpm_worker:notice] [pid 41200:tid 4147189504] AH00292: Apache/2.4.25 (Debian) mod_gnutls/0.8.2 GnuTLS/3.5.8 configured -- resuming normal operations
[Sun Mar 11 00:45:07.969143 2018] [mpm_worker:info] [pid 41200:tid 4147189504] AH00293: Server built: 2017-01-25T22:59:26
[Sun Mar 11 00:45:07.969150 2018] [core:notice] [pid 41200:tid 4147189504] AH00094: Command line: '/usr/sbin/apache2 -f /build/1st/mod-gnutls-0.8.2/test/tests/25_Disable_TLS_1.0/apache.conf'
[Sun Mar 11 00:45:07.969154 2018] [core:debug] [pid 41200:tid 4147189504] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1)
[Sun Mar 11 00:45:07.969163 2018] [mpm_worker:debug] [pid 41200:tid 4147189504] worker.c(1885): AH00294: Accept mutex: sysvsem (default: sysvsem)
[Sun Mar 11 00:45:07.969237 2018] [watchdog:debug] [pid 41230:tid 4147189504] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:07.973078 2018] [gnutls:info] [pid 41208:tid 4121951040] [client ::1:42443] GnuTLS: Handshake Failed (-8) 'A packet with illegal or unsupported version was received.'
[Sun Mar 11 00:45:07.973127 2018] [gnutls:debug] [pid 41208:tid 4121951040] gnutls_io.c(552): [client ::1:42443] mgs_filter_input : ap_get_brigade
[Sun Mar 11 00:45:07.973188 2018] [gnutls:debug] [pid 41208:tid 4121951040] gnutls_io.c(552): [client ::1:42443] mgs_filter_input : ap_get_brigade
[Sun Mar 11 00:45:09.358343 2018] [core:info] [pid 41200:tid 4147189504] AH00096: removed PID file /build/1st/mod-gnutls-0.8.2/test/apache2.pid (pid=41200)
[Sun Mar 11 00:45:09.358377 2018] [mpm_worker:notice] [pid 41200:tid 4147189504] AH00295: caught SIGTERM, shutting down
=======
test/logs/26_redirect_HTTP_to_HTTPS.error.log
[Sun Mar 11 00:45:09.407144 2018] [watchdog:debug] [pid 41647:tid 4147562240] mod_watchdog.c(460): AH02974: Watchdog: found parent providers.
[Sun Mar 11 00:45:09.407199 2018] [watchdog:debug] [pid 41647:tid 4147562240] mod_watchdog.c(506): AH02977: Watchdog: found child providers.
[Sun Mar 11 00:45:09.407205 2018] [watchdog:debug] [pid 41647:tid 4147562240] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_singleton_).
[Sun Mar 11 00:45:09.407209 2018] [watchdog:debug] [pid 41647:tid 4147562240] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_default_).
[Sun Mar 11 00:45:09.408692 2018] [watchdog:debug] [pid 41651:tid 4147562240] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:09.408980 2018] [watchdog:debug] [pid 41655:tid 4147562240] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:09.409203 2018] [mpm_worker:notice] [pid 41647:tid 4147562240] AH00292: Apache/2.4.25 (Debian) mod_gnutls/0.8.2 GnuTLS/3.5.8 configured -- resuming normal operations
[Sun Mar 11 00:45:09.409217 2018] [mpm_worker:info] [pid 41647:tid 4147562240] AH00293: Server built: 2017-01-25T22:59:26
[Sun Mar 11 00:45:09.409225 2018] [core:notice] [pid 41647:tid 4147562240] AH00094: Command line: '/usr/sbin/apache2 -f /build/1st/mod-gnutls-0.8.2/test/tests/26_redirect_HTTP_to_HTTPS/apache.conf'
[Sun Mar 11 00:45:09.409229 2018] [core:debug] [pid 41647:tid 4147562240] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1)
[Sun Mar 11 00:45:09.409241 2018] [mpm_worker:debug] [pid 41647:tid 4147562240] worker.c(1885): AH00294: Accept mutex: sysvsem (default: sysvsem)
[Sun Mar 11 00:45:09.409286 2018] [watchdog:debug] [pid 41681:tid 4147562240] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:09.417328 2018] [gnutls:debug] [pid 41651:tid 4113558336] gnutls_hooks.c(918): [client ::1:45034] mgs_hook_pre_connection declined connection
[Sun Mar 11 00:45:09.446987 2018] [gnutls:debug] [pid 41655:tid 4121951040] gnutls_cache.c(445): Cleaned up cache '/build/1st/mod-gnutls-0.8.2/test/cache/gnutls_cache'. Deleted 0 and left 8
[Sun Mar 11 00:45:09.452517 2018] [gnutls:debug] [pid 41655:tid 4121951040] gnutls_io.c(547): [client ::1:42445] mgs_filter_input: TLS connection opened.
[Sun Mar 11 00:45:09.452655 2018] [authz_core:debug] [pid 41655:tid 4121951040] mod_authz_core.c(835): [client ::1:42445] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:09.453080 2018] [gnutls:debug] [pid 41655:tid 4121951040] gnutls_io.c(513): [client ::1:42445] mgs_bye: TLS connection closed.
[Sun Mar 11 00:45:10.831856 2018] [core:info] [pid 41647:tid 4147562240] AH00096: removed PID file /build/1st/mod-gnutls-0.8.2/test/apache2.pid (pid=41647)
[Sun Mar 11 00:45:10.831886 2018] [mpm_worker:notice] [pid 41647:tid 4147562240] AH00295: caught SIGTERM, shutting down
=======
test/logs/27_OCSP_server.error.log
[Sun Mar 11 00:45:10.878629 2018] [watchdog:debug] [pid 41750:tid 4147918592] mod_watchdog.c(460): AH02974: Watchdog: found parent providers.
[Sun Mar 11 00:45:10.878667 2018] [watchdog:debug] [pid 41750:tid 4147918592] mod_watchdog.c(506): AH02977: Watchdog: found child providers.
[Sun Mar 11 00:45:10.878672 2018] [watchdog:debug] [pid 41750:tid 4147918592] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_singleton_).
[Sun Mar 11 00:45:10.878675 2018] [watchdog:debug] [pid 41750:tid 4147918592] mod_watchdog.c(514): AH02978: Watchdog: Looking for child (_default_).
[Sun Mar 11 00:45:10.879920 2018] [watchdog:debug] [pid 41752:tid 4147918592] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:10.880171 2018] [watchdog:debug] [pid 41754:tid 4147918592] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:10.880277 2018] [mpm_worker:notice] [pid 41750:tid 4147918592] AH00292: Apache/2.4.25 (Debian) mod_gnutls/0.8.2 GnuTLS/3.5.8 configured -- resuming normal operations
[Sun Mar 11 00:45:10.880287 2018] [mpm_worker:info] [pid 41750:tid 4147918592] AH00293: Server built: 2017-01-25T22:59:26
[Sun Mar 11 00:45:10.880293 2018] [core:notice] [pid 41750:tid 4147918592] AH00094: Command line: '/usr/sbin/apache2 -f /build/1st/mod-gnutls-0.8.2/test/tests/27_OCSP_server/apache.conf'
[Sun Mar 11 00:45:10.880296 2018] [core:debug] [pid 41750:tid 4147918592] log.c(1546): AH02639: Using SO_REUSEPORT: yes (1)
[Sun Mar 11 00:45:10.880303 2018] [mpm_worker:debug] [pid 41750:tid 4147918592] worker.c(1885): AH00294: Accept mutex: sysvsem (default: sysvsem)
[Sun Mar 11 00:45:10.880365 2018] [watchdog:debug] [pid 41767:tid 4147918592] mod_watchdog.c(563): AH02980: Watchdog: nothing configured?
[Sun Mar 11 00:45:10.883977 2018] [gnutls:debug] [pid 41752:tid 4122999616] gnutls_hooks.c(918): [client ::1:44582] mgs_hook_pre_connection declined connection
[Sun Mar 11 00:45:10.884101 2018] [authz_core:debug] [pid 41752:tid 4122999616] mod_authz_core.c(835): [client ::1:44582] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:10.884112 2018] [gnutls:debug] [pid 41752:tid 4122999616] gnutls_hooks.c(944): [client ::1:44582] request declined in mgs_hook_fixups
[Sun Mar 11 00:45:10.884147 2018] [authz_core:debug] [pid 41752:tid 4122999616] mod_authz_core.c(835): [client ::1:44582] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:10.884153 2018] [gnutls:debug] [pid 41752:tid 4122999616] gnutls_hooks.c(944): [client ::1:44582] request declined in mgs_hook_fixups
[Sun Mar 11 00:45:10.917882 2018] [gnutls:debug] [pid 41754:tid 4122999616] gnutls_cache.c(445): Cleaned up cache '/build/1st/mod-gnutls-0.8.2/test/cache/gnutls_cache'. Deleted 0 and left 9
[Sun Mar 11 00:45:10.917939 2018] [gnutls:debug] [pid 41754:tid 4122999616] gnutls_ocsp.c(775): [client ::1:42448] No valid OCSP response in cache, trying to update.
[Sun Mar 11 00:45:10.918320 2018] [gnutls:debug] [pid 41767:tid 4122999616] gnutls_hooks.c(918): [client ::1:44584] mgs_hook_pre_connection declined connection
[Sun Mar 11 00:45:10.918430 2018] [authz_core:debug] [pid 41767:tid 4122999616] mod_authz_core.c(835): [client ::1:44584] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:10.918441 2018] [gnutls:debug] [pid 41767:tid 4122999616] gnutls_hooks.c(944): [client ::1:44584] request declined in mgs_hook_fixups
[Sun Mar 11 00:45:10.918475 2018] [authz_core:debug] [pid 41767:tid 4122999616] mod_authz_core.c(835): [client ::1:44584] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:10.918481 2018] [gnutls:debug] [pid 41767:tid 4122999616] gnutls_hooks.c(944): [client ::1:44584] request declined in mgs_hook_fixups
[Sun Mar 11 00:45:10.944301 2018] [gnutls:debug] [pid 41754:tid 4122999616] gnutls_ocsp.c(385): CA flagged certificate as valid at Sun, 11 Mar 2018 12:45:10 GMT.
[Sun Mar 11 00:45:10.991388 2018] [gnutls:debug] [pid 41754:tid 4122999616] gnutls_io.c(547): [client ::1:42448] mgs_filter_input: TLS connection opened.
[Sun Mar 11 00:45:10.991469 2018] [authz_core:debug] [pid 41754:tid 4122999616] mod_authz_core.c(835): [client ::1:42448] AH01628: authorization result: granted (no directives)
[Sun Mar 11 00:45:10.991722 2018] [gnutls:debug] [pid 41754:tid 4122999616] gnutls_io.c(513): [client ::1:42448] mgs_bye: TLS connection closed.
[Sun Mar 11 00:45:12.383903 2018] [core:info] [pid 41750:tid 4147918592] AH00096: removed PID file /build/1st/mod-gnutls-0.8.2/test/apache2.pid (pid=41750)
[Sun Mar 11 00:45:12.383933 2018] [mpm_worker:notice] [pid 41750:tid 4147918592] AH00295: caught SIGTERM, shutting down
=======
debian/rules:16: recipe for target 'override_dh_auto_test' failed
make[1]: *** [override_dh_auto_test] Error 1
make[1]: Leaving directory '/build/1st/mod-gnutls-0.8.2'
debian/rules:6: recipe for target 'build' failed
make: *** [build] Error 2
dpkg-buildpackage: error: debian/rules build gave error exit status 2
I: copying local configuration
E: Failed autobuilding of package
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/40753 and its subdirectories
removed ‘/var/lib/jenkins/userContent/reproducible/debian/rbuild/unstable/i386/mod-gnutls_0.8.2-2.rbuild.log’
removed ‘/var/lib/jenkins/userContent/reproducible/debian/logs/unstable/i386/mod-gnutls_0.8.2-2.build1.log.gz’
+ echo 'Compressing the 1st log...'
Compressing the 1st log...
+ gzip -9cvn b1/build.log
b1/build.log:	 85.1%
+ chmod 644 /var/lib/jenkins/userContent/reproducible/debian/logs/unstable/i386/mod-gnutls_0.8.2-2.build1.log.gz
+ update_rbuildlog
+ chmod 644 /srv/reproducible-results/rbuild-debian-cZtPlt1g/tmp.vl4QdQxexA
+ mv /srv/reproducible-results/rbuild-debian-cZtPlt1g/tmp.vl4QdQxexA /var/lib/jenkins/userContent/reproducible/debian/rbuild/unstable/i386/mod-gnutls_0.8.2-2.rbuild.log
mv: error writing ‘/var/lib/jenkins/userContent/reproducible/debian/rbuild/unstable/i386/mod-gnutls_0.8.2-2.rbuild.log’: No space left on device
mv: failed to extend ‘/var/lib/jenkins/userContent/reproducible/debian/rbuild/unstable/i386/mod-gnutls_0.8.2-2.rbuild.log’: No space left on device
+ cleanup_all
+ echo 'Starting cleanup.'
Starting cleanup.
+ '[' 0 = 1 ']'
+ '[' '!' -z '' ']'
+ '[' '!' -f /srv/reproducible-results/rbuild-debian-cZtPlt1g/tmp.vl4QdQxexA ']'
+ gzip -9fvn /srv/reproducible-results/rbuild-debian-cZtPlt1g/tmp.vl4QdQxexA
/srv/reproducible-results/rbuild-debian-cZtPlt1g/tmp.vl4QdQxexA:	 84.6% -- replaced with /srv/reproducible-results/rbuild-debian-cZtPlt1g/tmp.vl4QdQxexA.gz
+ '[' master = master ']'
+ gen_package_html mod-gnutls
+ cd /srv/jenkins/bin
+ python3 -c 'import reproducible_html_packages as rep
pkg = rep.Package('\''mod-gnutls'\'', no_notes=True)
rep.gen_packages_html([pkg], no_clean=True)'
INFO: Starting at 2017-02-06 06:22:49.929034
CRITICAL: https://tests.reproducible-builds.org/debian/unstable/i386/mod-gnutls didn't produce a buildlog, even though it has been built.
INFO: Finished at 2017-02-06 06:22:50.258948, took: 0:00:00.329930
+ cd -
+ cd
+ rm -r /srv/reproducible-results/rbuild-debian-cZtPlt1g
+ echo 'All cleanup done.'
All cleanup done.
Mon  6 Feb 06:22:50 UTC 2017 - /srv/jenkins/bin/reproducible_build.sh stopped running as /tmp/jenkins-script-FTb6GUh1, which will now be removed.
Build step 'Execute shell' marked build as failure