[Pkg-auth-maintainers] Bug#952171: yubico-pam: FTBFS: dh_auto_test: error: cd build && make -j4 check VERBOSE=1 returned exit code 2

Sun Feb 23 13:14:52 GMT 2020

Source: yubico-pam
Version: 2.26-1
Severity: serious
Justification: FTBFS on amd64
Tags: bullseye sid ftbfs
Usertags: ftbfs-20200222 ftbfs-bullseye

Hi,

During a rebuild of all packages in sid, your package failed to build
on amd64.

Relevant part (hopefully):
> make[4]: Entering directory '/<<PKGBUILDDIR>>/build/tests'
> PASS: util_test
> FAIL: pam_test
> ===========================================
>    pam_yubico 2.26: tests/test-suite.log
> ===========================================
> 
> # TOTAL: 2
> # PASS:  1
> # SKIP:  0
> # XFAIL: 0
> # FAIL:  1
> # XPASS: 0
> # ERROR: 0
> 
> .. contents:: :depth: 2
> 
> FAIL: pam_test
> ==============
> 
> YKVAL mockup started on 30559 at ../../tests/aux/ykval.pl line 52.
> YKVAL mockup started on 17502 at ../../tests/aux/ykval.pl line 52.
> LDAP mockup started at ../../tests/aux/ldap.pl line 101, <DATA> line 755.
> in pam_get_user()
> in pam_get_item() 5 for 0
> in conv_func()
> validation for vvincredibletrerdegkkrkkneieultcjdghrejjbckh (on port 17502) at ../../tests/aux/ykval.pl line 62, <GEN1> line 1.
> in pam_strerror()
> in pam_set_data() yubico_setcred_return
> test 1 failed!
> debug: ../pam_yubico.c:838 (parse_cfg): called.
> debug: ../pam_yubico.c:839 (parse_cfg): flags 0 argc 4
> debug: ../pam_yubico.c:841 (parse_cfg): argv[0]=id=1
> debug: ../pam_yubico.c:841 (parse_cfg): argv[1]=url=http://localhost:17502/wsapi/2/verify?id=%d&otp=%s
> debug: ../pam_yubico.c:841 (parse_cfg): argv[2]=authfile=../../tests/aux/authfile
> debug: ../pam_yubico.c:841 (parse_cfg): argv[3]=debug
> debug: ../pam_yubico.c:842 (parse_cfg): id=1
> debug: ../pam_yubico.c:843 (parse_cfg): key=(null)
> debug: ../pam_yubico.c:844 (parse_cfg): debug=1
> debug: ../pam_yubico.c:845 (parse_cfg): debug_file=1
> debug: ../pam_yubico.c:846 (parse_cfg): alwaysok=0
> debug: ../pam_yubico.c:847 (parse_cfg): verbose_otp=0
> debug: ../pam_yubico.c:848 (parse_cfg): try_first_pass=0
> debug: ../pam_yubico.c:849 (parse_cfg): use_first_pass=0
> debug: ../pam_yubico.c:850 (parse_cfg): nullok=0
> debug: ../pam_yubico.c:851 (parse_cfg): authfile=../../tests/aux/authfile
> debug: ../pam_yubico.c:852 (parse_cfg): ldapserver=(null)
> debug: ../pam_yubico.c:853 (parse_cfg): ldap_uri=(null)
> debug: ../pam_yubico.c:854 (parse_cfg): ldap_bind_user=(null)
> debug: ../pam_yubico.c:855 (parse_cfg): ldap_bind_password=(null)
> debug: ../pam_yubico.c:856 (parse_cfg): ldap_filter=(null)
> debug: ../pam_yubico.c:857 (parse_cfg): ldap_cacertfile=(null)
> debug: ../pam_yubico.c:858 (parse_cfg): ldapdn=(null)
> debug: ../pam_yubico.c:859 (parse_cfg): user_attr=(null)
> debug: ../pam_yubico.c:860 (parse_cfg): yubi_attr=(null)
> debug: ../pam_yubico.c:861 (parse_cfg): yubi_attr_prefix=(null)
> debug: ../pam_yubico.c:862 (parse_cfg): url=http://localhost:17502/wsapi/2/verify?id=%d&otp=%s
> debug: ../pam_yubico.c:863 (parse_cfg): urllist=(null)
> debug: ../pam_yubico.c:864 (parse_cfg): capath=(null)
> debug: ../pam_yubico.c:865 (parse_cfg): cainfo=(null)
> debug: ../pam_yubico.c:866 (parse_cfg): proxy=(null)
> debug: ../pam_yubico.c:867 (parse_cfg): token_id_length=12
> debug: ../pam_yubico.c:868 (parse_cfg): mode=client
> debug: ../pam_yubico.c:869 (parse_cfg): chalresp_path=(null)
> debug: ../pam_yubico.c:899 (pam_sm_authenticate): pam_yubico version: 2.26
> debug: ../pam_yubico.c:914 (pam_sm_authenticate): get user returned: foo
> debug: ../pam_yubico.c:157 (authorize_user_token): Using system-wide auth_file ../../tests/aux/authfile
> debug: ../util.c:154 (check_user_token): Authorization line: foo:vvincredible
> debug: ../util.c:159 (check_user_token): Matched user: foo
> debug: ../util.c:165 (check_user_token): Authorization token: vvincredible
> debug: ../util.c:165 (check_user_token): Authorization token: (null)
> debug: ../util.c:154 (check_user_token): Authorization line: test:cccccccfhcbe:ccccccbchvth:
> debug: ../pam_yubico.c:1034 (pam_sm_authenticate): Tokens found for user
> debug: ../pam_yubico.c:1096 (pam_sm_authenticate): conv returned 44 bytes
> debug: ../pam_yubico.c:1110 (pam_sm_authenticate): Skipping first 0 bytes. Length is 44, token_id set to 12 and token OTP always 32.
> debug: ../pam_yubico.c:1118 (pam_sm_authenticate): OTP: vvincredibletrerdegkkrkkneieultcjdghrejjbckh ID: vvincredible 
> debug: ../pam_yubico.c:157 (authorize_user_token): Using system-wide auth_file ../../tests/aux/authfile
> debug: ../util.c:154 (check_user_token): Authorization line: foo:vvincredible
> debug: ../util.c:159 (check_user_token): Matched user: foo
> debug: ../util.c:165 (check_user_token): Authorization token: vvincredible
> debug: ../util.c:169 (check_user_token): Match user/token as foo/vvincredible
> debug: ../pam_yubico.c:1154 (pam_sm_authenticate): Token is associated to the user. Validating the OTP...
> debug: ../pam_yubico.c:1156 (pam_sm_authenticate): ykclient return value (109): Error performing curl
> debug: ../pam_yubico.c:1157 (pam_sm_authenticate): ykclient url used: 
> debug: ../pam_yubico.c:1220 (pam_sm_authenticate): done. [error]
> killed 11463, 11464 and 11465
> FAIL pam_test (exit status: 1)
> 
> ============================================================================
> Testsuite summary for pam_yubico 2.26
> ============================================================================
> # TOTAL: 2
> # PASS:  1
> # SKIP:  0
> # XFAIL: 0
> # FAIL:  1
> # XPASS: 0
> # ERROR: 0
> ============================================================================
> See tests/test-suite.log
> ============================================================================
> make[4]: *** [Makefile:735: test-suite.log] Error 1
> make[4]: Leaving directory '/<<PKGBUILDDIR>>/build/tests'
> make[3]: *** [Makefile:843: check-TESTS] Error 2
> make[3]: Leaving directory '/<<PKGBUILDDIR>>/build/tests'
> make[2]: *** [Makefile:924: check-am] Error 2
> make[2]: Leaving directory '/<<PKGBUILDDIR>>/build/tests'
> make[1]: *** [Makefile:785: check-recursive] Error 1
> make[1]: Leaving directory '/<<PKGBUILDDIR>>/build'
> dh_auto_test: error: cd build && make -j4 check VERBOSE=1 returned exit code 2

The full build log is available from:
   http://qa-logs.debian.net/2020/02/22/yubico-pam_2.26-1_unstable.log

A list of current common problems and possible solutions is available at
http://wiki.debian.org/qa.debian.org/FTBFS . You're welcome to contribute!

About the archive rebuild: The rebuild was done on EC2 VM instances from
Amazon Web Services, using a clean, minimal and up-to-date chroot. Every
failed build was retried once to eliminate random failures.