============================== lbuild-nightly.sh: failure at Wed Feb 15 01:38:09 CET 2017 --> Processing Dependency: sfa-common for package: sfa-3.1-21.onelab.2017.02.15.x86_64 ---> Package sfa-client.x86_64 0:3.1-21.onelab.2017.02.15 set to be installed ---> Package sfa-plc.x86_64 0:3.1-21.onelab.2017.02.15 set to be installed ---> Package sfa-sfatables.x86_64 0:3.1-21.onelab.2017.02.15 set to be installed --> Running transaction check ---> Package python-migrate.noarch 0:0.6-5.fc14 set to be installed --> Processing Dependency: python-tempita for package: python-migrate-0.6-5.fc14.noarch --> Processing Dependency: python-setuptools for package: python-migrate-0.6-5.fc14.noarch --> Processing Dependency: python-decorator for package: python-migrate-0.6-5.fc14.noarch ---> Package python-sqlalchemy.x86_64 0:0.6.8-1.fc14 set to be installed ---> Package sfa-common.x86_64 0:3.1-21.onelab.2017.02.15 set to be installed --> Processing Dependency: python-dateutil for package: sfa-common-3.1-21.onelab.2017.02.15.x86_64 --> Processing Dependency: xmlsec1-openssl-devel for package: sfa-common-3.1-21.onelab.2017.02.15.x86_64 --> Processing Dependency: libxslt-python for package: sfa-common-3.1-21.onelab.2017.02.15.x86_64 --> Processing Dependency: python-ZSI for package: sfa-common-3.1-21.onelab.2017.02.15.x86_64 --> Running transaction check ---> Package libxslt-python.x86_64 0:1.1.26-3.fc14 set to be installed ---> Package python-ZSI.noarch 0:2.0-8.fc14 set to be installed ---> Package python-dateutil.noarch 0:1.5-3.fc14 set to be installed ---> Package python-decorator.noarch 0:3.2.1-1.fc14 set to be installed ---> Package python-setuptools.noarch 0:0.6.24-1.fc14 set to be installed ---> Package python-tempita.noarch 0:0.4-5.fc14 set to be installed ---> Package xmlsec1-openssl-devel.x86_64 0:1.2.16-3.fc14 set to be installed --> Processing Dependency: xmlsec1-devel = 1.2.16-3.fc14 for package: xmlsec1-openssl-devel-1.2.16-3.fc14.x86_64 --> Processing Dependency: pkgconfig(libxslt) >= 1.0.20 for package: xmlsec1-openssl-devel-1.2.16-3.fc14.x86_64 --> Processing Dependency: pkgconfig(libxml-2.0) >= 2.7.4 for package: xmlsec1-openssl-devel-1.2.16-3.fc14.x86_64 --> Running transaction check ---> Package libxml2-devel.x86_64 0:2.7.7-3.fc14 set to be installed --> Processing Dependency: zlib-devel for package: libxml2-devel-2.7.7-3.fc14.x86_64 ---> Package libxslt-devel.x86_64 0:1.1.26-3.fc14 set to be installed --> Processing Dependency: libgcrypt-devel for package: libxslt-devel-1.1.26-3.fc14.x86_64 ---> Package xmlsec1-devel.x86_64 0:1.2.16-3.fc14 set to be installed --> Processing Dependency: openssl-devel >= 0.9.6 for package: xmlsec1-devel-1.2.16-3.fc14.x86_64 --> Running transaction check ---> Package libgcrypt-devel.x86_64 0:1.4.5-4.fc13 set to be installed --> Processing Dependency: libgpg-error-devel for package: libgcrypt-devel-1.4.5-4.fc13.x86_64 ---> Package openssl-devel.x86_64 0:1.0.0e-1.fc14 set to be installed --> Processing Dependency: krb5-devel for package: openssl-devel-1.0.0e-1.fc14.x86_64 ---> Package zlib-devel.x86_64 0:1.2.5-2.fc14 set to be installed --> Running transaction check ---> Package krb5-devel.x86_64 0:1.8.4-3.fc14 set to be installed --> Processing Dependency: libcom_err-devel for package: krb5-devel-1.8.4-3.fc14.x86_64 --> Processing Dependency: keyutils-libs-devel for package: krb5-devel-1.8.4-3.fc14.x86_64 --> Processing Dependency: libselinux-devel for package: krb5-devel-1.8.4-3.fc14.x86_64 ---> Package libgpg-error-devel.x86_64 0:1.9-1.fc14 set to be installed --> Running transaction check ---> Package keyutils-libs-devel.x86_64 0:1.2-6.fc12 set to be installed ---> Package libcom_err-devel.x86_64 0:1.41.12-6.fc14 set to be installed ---> Package libselinux-devel.x86_64 0:2.0.96-6.fc14.1 set to be installed --> Processing Dependency: libsepol-devel >= 2.0.32-1 for package: libselinux-devel-2.0.96-6.fc14.1.x86_64 --> Processing Dependency: pkgconfig(libsepol) for package: libselinux-devel-2.0.96-6.fc14.1.x86_64 --> Running transaction check ---> Package libsepol-devel.x86_64 0:2.0.41-3.fc14 set to be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: sfa x86_64 3.1-21.onelab.2017.02.15 myplc 71 k sfa-client x86_64 3.1-21.onelab.2017.02.15 myplc 49 k sfa-plc x86_64 3.1-21.onelab.2017.02.15 myplc 135 k sfa-sfatables x86_64 3.1-21.onelab.2017.02.15 myplc 71 k Installing for dependencies: keyutils-libs-devel x86_64 1.2-6.fc12 fedora 29 k krb5-devel x86_64 1.8.4-3.fc14 updates 1.2 M libcom_err-devel x86_64 1.41.12-6.fc14 updates 26 k libgcrypt-devel x86_64 1.4.5-4.fc13 fedora 117 k libgpg-error-devel x86_64 1.9-1.fc14 fedora 14 k libselinux-devel x86_64 2.0.96-6.fc14.1 updates 136 k libsepol-devel x86_64 2.0.41-3.fc14 fedora 64 k libxml2-devel x86_64 2.7.7-3.fc14 updates 1.1 M libxslt-devel x86_64 1.1.26-3.fc14 fedora 431 k libxslt-python x86_64 1.1.26-3.fc14 fedora 137 k openssl-devel x86_64 1.0.0e-1.fc14 updates 1.1 M python-ZSI noarch 2.0-8.fc14 fedora 423 k python-dateutil noarch 1.5-3.fc14 updates 85 k python-decorator noarch 3.2.1-1.fc14 updates 24 k python-migrate noarch 0.6-5.fc14 updates 206 k python-setuptools noarch 0.6.24-1.fc14 updates 345 k python-sqlalchemy x86_64 0.6.8-1.fc14 updates 1.8 M python-tempita noarch 0.4-5.fc14 fedora 38 k sfa-common x86_64 3.1-21.onelab.2017.02.15 myplc 530 k xmlsec1-devel x86_64 1.2.16-3.fc14 updates 457 k xmlsec1-openssl-devel x86_64 1.2.16-3.fc14 updates 12 k zlib-devel x86_64 1.2.5-2.fc14 fedora 45 k Transaction Summary ================================================================================ Install 26 Package(s) Total download size: 8.5 M Installed size: 37 M Downloading Packages: -------------------------------------------------------------------------------- Total 28 MB/s | 8.5 MB 00:00 Running rpm_check_debug Running Transaction Test Transaction Test Succeeded Running Transaction Installing : libxslt-python-1.1.26-3.fc14.x86_64 1/26 Installing : zlib-devel-1.2.5-2.fc14.x86_64 2/26 Installing : libxml2-devel-2.7.7-3.fc14.x86_64 3/26 Installing : python-sqlalchemy-0.6.8-1.fc14.x86_64 4/26 Installing : python-setuptools-0.6.24-1.fc14.noarch 5/26 Installing : python-ZSI-2.0-8.fc14.noarch 6/26 Installing : libsepol-devel-2.0.41-3.fc14.x86_64 7/26 Installing : libselinux-devel-2.0.96-6.fc14.1.x86_64 8/26 Installing : libcom_err-devel-1.41.12-6.fc14.x86_64 9/26 Installing : libgpg-error-devel-1.9-1.fc14.x86_64 10/26 Installing : libgcrypt-devel-1.4.5-4.fc13.x86_64 11/26 Installing : libxslt-devel-1.1.26-3.fc14.x86_64 12/26 Installing : python-tempita-0.4-5.fc14.noarch 13/26 Installing : python-dateutil-1.5-3.fc14.noarch 14/26 Installing : keyutils-libs-devel-1.2-6.fc12.x86_64 15/26 Installing : krb5-devel-1.8.4-3.fc14.x86_64 16/26 Installing : openssl-devel-1.0.0e-1.fc14.x86_64 17/26 Installing : xmlsec1-devel-1.2.16-3.fc14.x86_64 18/26 Installing : xmlsec1-openssl-devel-1.2.16-3.fc14.x86_64 19/26 Installing : sfa-common-3.1-21.onelab.2017.02.15.x86_64 20/26 Installing : python-decorator-3.2.1-1.fc14.noarch 21/26 Installing : python-migrate-0.6-5.fc14.noarch 22/26 Installing : sfa-3.1-21.onelab.2017.02.15.x86_64 23/26 Installing : sfa-sfatables-3.1-21.onelab.2017.02.15.x86_64 24/26 Installing : sfa-plc-3.1-21.onelab.2017.02.15.x86_64 25/26 Installing : sfa-client-3.1-21.onelab.2017.02.15.x86_64 26/26 Installed: sfa.x86_64 0:3.1-21.onelab.2017.02.15 sfa-client.x86_64 0:3.1-21.onelab.2017.02.15 sfa-plc.x86_64 0:3.1-21.onelab.2017.02.15 sfa-sfatables.x86_64 0:3.1-21.onelab.2017.02.15 Dependency Installed: keyutils-libs-devel.x86_64 0:1.2-6.fc12 krb5-devel.x86_64 0:1.8.4-3.fc14 libcom_err-devel.x86_64 0:1.41.12-6.fc14 libgcrypt-devel.x86_64 0:1.4.5-4.fc13 libgpg-error-devel.x86_64 0:1.9-1.fc14 libselinux-devel.x86_64 0:2.0.96-6.fc14.1 libsepol-devel.x86_64 0:2.0.41-3.fc14 libxml2-devel.x86_64 0:2.7.7-3.fc14 libxslt-devel.x86_64 0:1.1.26-3.fc14 libxslt-python.x86_64 0:1.1.26-3.fc14 openssl-devel.x86_64 0:1.0.0e-1.fc14 python-ZSI.noarch 0:2.0-8.fc14 python-dateutil.noarch 0:1.5-3.fc14 python-decorator.noarch 0:3.2.1-1.fc14 python-migrate.noarch 0:0.6-5.fc14 python-setuptools.noarch 0:0.6.24-1.fc14 python-sqlalchemy.x86_64 0:0.6.8-1.fc14 python-tempita.noarch 0:0.4-5.fc14 sfa-common.x86_64 0:3.1-21.onelab.2017.02.15 xmlsec1-devel.x86_64 0:1.2.16-3.fc14 xmlsec1-openssl-devel.x86_64 0:1.2.16-3.fc14 zlib-devel.x86_64 0:1.2.5-2.fc14 Complete! -> 01:37:46 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 yum-complete-transaction -y Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. No unfinished transactions left. -> 01:37:47 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 rpm -q sfa sfa-plc sfa-sfatables sfa-client Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. sfa-3.1-21.onelab.2017.02.15.x86_64 sfa-plc-3.1-21.onelab.2017.02.15.x86_64 sfa-sfatables-3.1-21.onelab.2017.02.15.x86_64 sfa-client-3.1-21.onelab.2017.02.15.x86_64 * 01:37:47 -- ********** 1 SUCCESSFUL step sfa_install_all on plctest1_vplc14 TRACE: 1 01-37-41->6s=0:00:06.322696s status=OK step=sfa_install_all plc=plctest1_vplc14 force=False * 01:37:47 -- ********** 1 RUNNING step sfa_configure on plc plctest1_vplc14 -> 01:37:47 -- + mkdir -p conf.plctest1_vplc14 -> 01:37:47 -- + cat conf.plctest1_vplc14/sfa-config-tty e SFA_SM_ENABLED false e SFA_AGGREGATE_HOST vplc14.pl.sophia.inria.fr e SFA_AGGREGATE_ENABLED true e SFA_PLC_URL https://vplc14.pl.sophia.inria.fr:443/PLCAPI/ e SFA_API_LOGLEVEL 1 e SFA_INTERFACE_HRN a e SFA_DB_HOST vplc14.pl.sophia.inria.fr e SFA_REGISTRY_ROOT_AUTH a e SFA_PLC_PASSWORD test++ e SFA_SM_HOST vplc14.pl.sophia.inria.fr e SFA_PLC_USER root@test.onelab.eu e SFA_GENERIC_FLAVOUR pl e SFA_REGISTRY_HOST vplc14.pl.sophia.inria.fr w R q -> 01:37:47 -- + cat conf.plctest1_vplc14/sfa-config-tty + ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 sfa-config-tty Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. + service sfa reload Reloading sfa configuration (via systemctl): Job failed, see system logs for details. [FAILED] Created directory /etc/sfa/configs Enter command (u for usual changes, w to save, ? for help) == sfa_sm_enabled : [false] Enter command (u for usual changes, w to save, ? for help) == sfa_aggregate_host : [localhost] Enter command (u for usual changes, w to save, ? for help) == sfa_aggregate_enabled : [true] Enter command (u for usual changes, w to save, ? for help) == sfa_plc_url : [https://localhost:443/PLCAPI/] Enter command (u for usual changes, w to save, ? for help) == sfa_api_loglevel : [0] Enter command (u for usual changes, w to save, ? for help) == sfa_interface_hrn : [plc] Enter command (u for usual changes, w to save, ? for help) == sfa_db_host : [localhost] Enter command (u for usual changes, w to save, ? for help) == sfa_registry_root_auth : [plc] Enter command (u for usual changes, w to save, ? for help) == sfa_plc_password : [root] Enter command (u for usual changes, w to save, ? for help) == sfa_sm_host : [localhost] Enter command (u for usual changes, w to save, ? for help) == sfa_plc_user : [root@localhost.localdomain] Enter command (u for usual changes, w to save, ? for help) == sfa_generic_flavour : [pl] Enter command (u for usual changes, w to save, ? for help) == sfa_registry_host : [localhost] Enter command (u for usual changes, w to save, ? for help) Wrote /etc/sfa/configs/site_config Merged /etc/sfa/default_config.xml and /etc/sfa/configs/site_config into /etc/sfa/sfa_config You might want to type 'r' (restart sfa), 'R' (reload sfa) or 'q' (quit) Enter command (u for usual changes, w to save, ? for help) Enter command (u for usual changes, w to save, ? for help) * 01:37:49 -- ********** 1 SUCCESSFUL step sfa_configure on plctest1_vplc14 TRACE: 1 01-37-47->1s=0:00:01.231159s status=OK step=sfa_configure plc=plctest1_vplc14 force=False * 01:37:49 -- ********** 1 RUNNING step cross_sfa_configure on plc plctest1_vplc14 * 01:37:49 -- ********** 1 SUCCESSFUL step cross_sfa_configure on plctest1_vplc14 TRACE: 1 01-37-49->0s=0:00:00.000328s status=OK step=cross_sfa_configure plc=plctest1_vplc14 force=False * 01:37:49 -- ********** 1 RUNNING step sfa_start on plc plctest1_vplc14 -> 01:37:49 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 sed -i -e '\"s,env' '-i,env,\"' /sbin/service Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. -> 01:37:49 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 SYSTEMCTL_SKIP_REDIRECT=true service sfa start Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. Upgrading to 2.1 or higher: make sure to run import SFA: Checking for PostgreSQL server[ OK ] SFA: installing peer certs [ OK ] [ OK ] SFA: Registry [ OK ] [ OK ] SFA: Aggregate [ OK ] [ OK ] * 01:37:54 -- ********** 1 SUCCESSFUL step sfa_start on plctest1_vplc14 TRACE: 1 01-37-49->5s=0:00:05.099133s status=OK step=sfa_start plc=plctest1_vplc14 force=False * 01:37:54 -- ********** 1 RUNNING step sfa_import on plc plctest1_vplc14 -> 01:37:54 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 sfaadmin reg import_registry Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. * 01:37:57 -- ********** 1 SUCCESSFUL step sfa_import on plctest1_vplc14 TRACE: 1 01-37-54->3s=0:00:03.075407s status=OK step=sfa_import plc=plctest1_vplc14 force=False * 01:37:57 -- ********** 1 RUNNING step sfi_configure on plc plctest1_vplc14 -> 01:37:57 -- + rm -rf conf.plctest1_vplc14/dot-sfi/sfi -> 01:37:57 -- + mkdir -p conf.plctest1_vplc14/dot-sfi/sfi * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.pi-user.pkey * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.pi-user.pub * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.regular-user.pkey * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.regular-user.pub * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/sfi_config -> 01:37:57 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks mkdir -p /vservers/2017.02.15--f14-1-vplc14///root/sfi Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. -> 01:37:57 -- + scp -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -r conf.plctest1_vplc14/dot-sfi/sfi buzzcocks:/vservers/2017.02.15--f14-1-vplc14///root * 01:37:58 -- ********** 1 SUCCESSFUL step sfi_configure on plctest1_vplc14 TRACE: 1 01-37-57->1s=0:00:01.048925s status=OK step=sfi_configure plc=plctest1_vplc14 force=False * 01:37:58 -- ********** 1 RUNNING step sfa_register_site on plc plctest1_vplc14 -> 01:37:58 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 sfaadmin reg register -t authority -x a.sfa Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. * 01:37:59 -- ********** 1 SUCCESSFUL step sfa_register_site on plctest1_vplc14 TRACE: 1 01-37-58->1s=0:00:01.121054s status=OK step=sfa_register_site plc=plctest1_vplc14 force=False * 01:37:59 -- ********** 1 RUNNING step sfa_register_pi on plc plctest1_vplc14 -> 01:37:59 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 sfaadmin reg register -t user -x a.sfa.pi-user --email pi-user@test.onelab.eu --key /root/sfi/a.sfa.pi-user.pub Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. From: Regression TestLab Support , To: *from*sfa* *from*sfa* , Subject: Regression TestLab account enabled -> 01:38:01 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 sfaadmin reg update -t authority -x a.sfa --pi a.sfa.pi-user Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. DO NOT REMOVE ME before driver.update, record= * 01:38:02 -- ********** 1 SUCCESSFUL step sfa_register_pi on plctest1_vplc14 TRACE: 1 01-37-59->2s=0:00:02.793071s status=OK step=sfa_register_pi plc=plctest1_vplc14 force=False * 01:38:02 -- ********** 1 RUNNING step sfa_register_user on plc plctest1_vplc14 -> 01:38:02 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 sfi -d /root/sfi -u a.sfa.pi-user register --type user --xrn a.sfa.regular-user --email regular-user@test.onelab.eu --extra first_name=Fake --extra last_name=SFA -k /root/sfi/a.sfa.regular-user.pub Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. Could not produce/retrieve /root/sfi/a.sfa.pi-user.user.cred ( -- Internal SFA API error: Type X509Name doesn't define __format__) BEG TRACEBACK Traceback (most recent call last): File "/usr/lib/python2.7/site-packages/sfa/client/sfaclientlib.py", line 370, in wrapped produce_method(self, filename, *args, **kw) File "/usr/lib/python2.7/site-packages/sfa/client/sfaclientlib.py", line 163, in my_credential_produce certificate_string, hrn, "user") File "/usr/lib/python2.7/site-packages/sfa/client/sfaserverproxy.py", line 123, in func return getattr(self.serverproxy, name)(*args, **kwds) File "/usr/lib64/python2.7/xmlrpclib.py", line 1224, in __call__ return self.__send(self.__name, args) File "/usr/lib64/python2.7/xmlrpclib.py", line 1570, in __request verbose=self.__verbose File "/usr/lib64/python2.7/xmlrpclib.py", line 1264, in request return self.single_request(host, handler, request_body, verbose) File "/usr/lib64/python2.7/xmlrpclib.py", line 1297, in single_request return self.parse_response(response) File "/usr/lib64/python2.7/xmlrpclib.py", line 1468, in parse_response return u.close() File "/usr/lib/python2.7/site-packages/sfa/client/sfaserverproxy.py", line 36, in close raise ServerException(e.faultString) ServerException: Internal SFA API error: Type X509Name doesn't define __format__ Could not produce/retrieve /root/sfi/a.sfa.pi-user.user.cred ( -- Internal SFA API error: Type X509Name doesn't define __format__) END TRACEBACK Traceback (most recent call last): File "/usr/bin/sfi", line 9, in sys.exit(Sfi().main()) File "/usr/lib/python2.7/site-packages/sfa/client/sfi.py", line 646, in main self.bootstrap() File "/usr/lib/python2.7/site-packages/sfa/client/sfi.py", line 785, in bootstrap client_bootstrap.bootstrap_my_gid() File "/usr/lib/python2.7/site-packages/sfa/client/sfaclientlib.py", line 254, in bootstrap_my_gid self.my_credential() File "/usr/lib/python2.7/site-packages/sfa/client/sfaclientlib.py", line 379, in wrapped raise Exception(message) Exception: Could not produce/retrieve /root/sfi/a.sfa.pi-user.user.cred ( -- Internal SFA API error: Type X509Name doesn't define __format__) * 01:38:03 -- ********** 1 FAILED step sfa_register_user on plctest1_vplc14 (discarded from further steps) TRACE: 1 01-38-02->1s=0:00:01.220828s status=KO step=sfa_register_user plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_update_user on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000099s status=UNDEF step=sfa_update_user plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_register_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000053s status=UNDEF step=sfa_register_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_renew_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000046s status=UNDEF step=sfa_renew_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_remove_user_from_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000056s status=UNDEF step=sfa_remove_user_from_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfi_show_slice_researchers on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000045s status=UNDEF step=sfi_show_slice_researchers plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_insert_user_in_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000044s status=UNDEF step=sfa_insert_user_in_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfi_show_slice_researchers on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000044s status=UNDEF step=sfi_show_slice_researchers plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_discover on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000047s status=UNDEF step=sfa_discover plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_rspec on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000044s status=UNDEF step=sfa_rspec plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_allocate on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000043s status=UNDEF step=sfa_allocate plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_provision on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_provision plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_describe on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_describe plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_check_slice_plc on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_check_slice_plc plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_update_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_update_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfi_list on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfi_list plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfi_show_site on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000043s status=UNDEF step=sfi_show_site plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_utest on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000060s status=UNDEF step=sfa_utest plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step probe_kvm_iptables on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000044s status=UNDEF step=probe_kvm_iptables plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ping_node on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000052s status=UNDEF step=ping_node plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ssh_node_debug on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000043s status=UNDEF step=ssh_node_debug plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step plcsh_stress_test on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000043s status=UNDEF step=plcsh_stress_test plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ssh_node_boot on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=ssh_node_boot plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step node_bmlogs on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=node_bmlogs plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000043s status=UNDEF step=ssh_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_basics on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=ssh_slice_basics plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step check_initscripts on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000044s status=UNDEF step=check_initscripts plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_sfa on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000046s status=UNDEF step=ssh_slice_sfa plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_rspec_empty on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000043s status=UNDEF step=sfa_rspec_empty plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_allocate_empty on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000043s status=UNDEF step=sfa_allocate_empty plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_provision_empty on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_provision_empty plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_check_slice_plc_empty on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_check_slice_plc_empty plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_delete_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_delete_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step sfa_delete_user on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=sfa_delete_user plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step cross_check_tcp on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=cross_check_tcp plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step check_system_slice on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=check_system_slice plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step debug_nodemanager on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000056s status=UNDEF step=debug_nodemanager plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step empty_slices on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000045s status=UNDEF step=empty_slices plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_off on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=ssh_slice_off plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step slice_fs_deleted_ignore on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000046s status=UNDEF step=slice_fs_deleted_ignore plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step fill_slices on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000053s status=UNDEF step=fill_slices plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_again on plctest1_vplc14 (has failed sfa_register_user) TRACE: 1 01-38-03->0s=0:00:00.000042s status=UNDEF step=ssh_slice_again plc=plctest1_vplc14 force=False * 01:38:03 -- ********** 1 RUNNING step gather_logs (forced after sfa_register_user has failed) on plc plctest1_vplc14 -------------------- TestPlc.gather_logs : PLC's /var/log -> 01:38:03 -- + mkdir -p logs/myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14 -> 01:38:03 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 tar -C /var/log/ -cf - . + tar -C logs/myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14 -xf - Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. -> 01:38:04 -- + chmod a+r,a+x logs/myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd -------------------- TestPlc.gather_logs : PLC's /var/lib/psql/data/pg_log/ -> 01:38:04 -- + mkdir -p logs/myplc.pgsql-log.plctest1_vplc14.2017.02.15--f14-1-vplc14 -> 01:38:04 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 tar -C /var/lib/pgsql/data/pg_log/ -cf - . + tar -C logs/myplc.pgsql-log.plctest1_vplc14.2017.02.15--f14-1-vplc14 -xf - Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. -------------------- TestPlc.gather_logs : PLC's /root/sfi/ -> 01:38:04 -- + mkdir -p logs/sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14 -> 01:38:04 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null buzzcocks ssh -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null vplc14 tar -C /root/sfi/ -cf - . + tar -C logs/sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14 -xf - Warning: Permanently added 'buzzcocks' (ECDSA) to the list of known hosts. Warning: Permanently added 'vplc14' (RSA) to the list of known hosts. -------------------- TestPlc.gather_logs : nodes's QEMU logs -> 01:38:05 -- + scp -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 boxtops:/vservers/2017.02.15--f14/qemu-vnode12.pl.sophia.inria.fr/log.txt logs/node.qemu.vnode12.pl.sophia.inria.fr.txt -------------------- TestPlc.gather_logs : nodes's /var/log -> 01:38:06 -- + mkdir -p logs/node.var-log.vnode12.pl.sophia.inria.fr -> 01:38:06 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null -i keys/key_admin.rsa vnode12.pl.sophia.inria.fr tar -C /var/log -cf - . + tar -C logs/node.var-log.vnode12.pl.sophia.inria.fr -xf - Warning: Permanently added 'vnode12.pl.sophia.inria.fr' (RSA) to the list of known hosts. Permission denied (publickey). tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors -------------------- TestPlc.gather_logs : sample sliver's /var/log -> 01:38:06 -- + mkdir -p logs/sliver.var-log.inri_sl1@vnode12.pl.sophia.inria.fr -> 01:38:06 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null -i keys/key_admin.rsa vnode12.pl.sophia.inria.fr tar -C /vservers/inri_sl1/var/log -cf - . + tar -C logs/sliver.var-log.inri_sl1@vnode12.pl.sophia.inria.fr -xf - Warning: Permanently added 'vnode12.pl.sophia.inria.fr' (RSA) to the list of known hosts. Permission denied (publickey). tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors -> 01:38:06 -- + mkdir -p logs/sliver.var-log.inri_sl2@vnode12.pl.sophia.inria.fr -> 01:38:06 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null -i keys/key_admin.rsa vnode12.pl.sophia.inria.fr tar -C /vservers/inri_sl2/var/log -cf - . + tar -C logs/sliver.var-log.inri_sl2@vnode12.pl.sophia.inria.fr -xf - Warning: Permanently added 'vnode12.pl.sophia.inria.fr' (RSA) to the list of known hosts. Permission denied (publickey). tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors -> 01:38:06 -- + mkdir -p logs/sliver.var-log.inri_sl3@vnode12.pl.sophia.inria.fr -> 01:38:06 -- + ssh -n -o BatchMode=yes -o StrictHostKeyChecking=no -o CheckHostIP=no -o ConnectTimeout=5 -o UserKnownHostsFile=/dev/null -i keys/key_admin.rsa vnode12.pl.sophia.inria.fr tar -C /vservers/inri_sl3/var/log -cf - . + tar -C logs/sliver.var-log.inri_sl3@vnode12.pl.sophia.inria.fr -xf - Warning: Permanently added 'vnode12.pl.sophia.inria.fr' (RSA) to the list of known hosts. Permission denied (publickey). tar: This does not look like a tar archive tar: Exiting with failure status due to previous errors * 01:38:06 -- ********** 1 SUCCESSFUL step gather_logs on plctest1_vplc14 TRACE: 1 01-38-03->3s=0:00:03.044125s status=OK step=gather_logs plc=plctest1_vplc14 force=True TestMain exit code 1 run_log exit_code 1 + retcod=1 + set -e + trap failure ERR INT + echo 'retcod from run_log' 1 retcod from run_log 1 + case $retcod in + success= + IGNORED= ++ rootdir 2017.02.15--f14 ++ slice=2017.02.15--f14 ++ shift ++ echo /vservers/2017.02.15--f14 + mkdir -p /vservers/2017.02.15--f14/build/testlogs ++ rootdir 2017.02.15--f14 ++ slice=2017.02.15--f14 ++ shift ++ echo /vservers/2017.02.15--f14 + rsync --verbose --archive root@testmaster.onelab.eu:2017.02.15--f14/logs/ /vservers/2017.02.15--f14/build/testlogs receiving incremental file list node.qemu.vnode12.pl.sophia.inria.fr.txt run -> run-01-35.txt run-01-35.txt trace -> trace-01-35.txt trace-01-35.txt myplc.pgsql-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/ myplc.pgsql-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/postgresql-Wed.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/ myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/boot.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/btmp myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/cron myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/dmesg myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/dnf.librepo.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/dnf.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/dnf.rpm.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/hawkey.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/lastlog myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/maillog myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/messages myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/myslice.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/pgsql myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/php.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/plc_api_ratelimit.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/secure myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/sfa.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/sfa_import.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/spooler myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/tallylog myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/wtmp myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/yum.log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/bm/ myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd/ myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd/access_log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd/error_log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd/sfa_access_log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd/ssl_access_log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd/ssl_error_log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/httpd/ssl_request_log myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/mail/ myplc.var-log.plctest1_vplc14.2017.02.15--f14-1-vplc14/mail/statistics node.var-log.vnode12.pl.sophia.inria.fr/ sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/ sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/a.sfa.pi-user.pkey sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/a.sfa.pi-user.pub sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/a.sfa.pi-user.sscert sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/a.sfa.regular-user.pkey sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/a.sfa.regular-user.pub sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/sfi_config sfi.plctest1_vplc14.2017.02.15--f14-1-vplc14/sfi_config.sh sliver.var-log.inri_sl1@vnode12.pl.sophia.inria.fr/ sliver.var-log.inri_sl2@vnode12.pl.sophia.inria.fr/ sliver.var-log.inri_sl3@vnode12.pl.sophia.inria.fr/ sent 846 bytes received 1,489,827 bytes 596,269.20 bytes/sec total size is 1,486,064 speedup is 1.00 ++ rootdir 2017.02.15--f14 ++ slice=2017.02.15--f14 ++ shift ++ echo /vservers/2017.02.15--f14 + chmod -R a+r /vservers/2017.02.15--f14/build/testlogs/ ++ rootdir 2017.02.15--f14 ++ slice=2017.02.15--f14 ++ shift ++ echo /vservers/2017.02.15--f14 + webpublish_rsync_dir /build/onelab//2017.02.15--f14/testlogs/ /vservers/2017.02.15--f14/build/testlogs/ + rsync --archive --delete /vservers/2017.02.15--f14/build/testlogs/ root@build.onelab.eu:/build/onelab//2017.02.15--f14/testlogs/ ++ date + echo '============================== END lbuild-nightly.sh:run_log on Wed Feb 15 01:38:08 CET 2017' ============================== END lbuild-nightly.sh:run_log on Wed Feb 15 01:38:08 CET 2017 + '[' -z '' ']' + echo 'Tests have failed - bailing out' Tests have failed - bailing out + failure + set -x + '[' -z /build/onelab//2017.02.15--f14/log.txt ']' + webpublish mkdir -p /build/onelab//2017.02.15--f14 + ssh root@build.onelab.eu mkdir -p /build/onelab//2017.02.15--f14 + webpublish_cp_local_to_remote /vservers/2017.02.15--f14/log.txt /build/onelab//2017.02.15--f14/log.txt + scp /vservers/2017.02.15--f14/log.txt root@build.onelab.eu:/build/onelab//2017.02.15--f14/log.txt ******************** BEG SUMMARY >>> ==================== BEG LXC Transcript of vm creation >>> + echo '==================== BEG LXC Transcript of vm creation' >>> ==================== END LXC Transcript of vm creation >>> ==================== Within LXC BEG Wed Feb 15 01:08:55 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM kernel Wed Feb 15 01:09:21 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM kernel Wed Feb 15 01:16:11 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM ipfwroot Wed Feb 15 01:16:14 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM ipfwroot Wed Feb 15 01:16:28 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM ipfwslice Wed Feb 15 01:16:28 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM ipfwslice Wed Feb 15 01:16:29 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM comgt Wed Feb 15 01:16:29 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM comgt Wed Feb 15 01:16:30 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM umts-backend Wed Feb 15 01:16:30 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM umts-backend Wed Feb 15 01:16:30 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM umts-frontend Wed Feb 15 01:16:30 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM umts-frontend Wed Feb 15 01:16:31 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM iptables Wed Feb 15 01:16:36 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM iptables Wed Feb 15 01:17:09 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM util-vserver Wed Feb 15 01:17:10 CET 2017 >>> * NOTE: a plain "make install" installs only the files under $(prefix) >>> * which might be insufficient. To complete the installation, >>> * "make install-distribution" should be executed. See README, >>> * "Notes for distributors" for details. >>> * NOTE: a plain "make install" installs only the files under $(prefix) >>> * which might be insufficient. To complete the installation, >>> * "make install-distribution" should be executed. See README, >>> * "Notes for distributors" for details. >>> * NOTE: a plain "make install" installs only the files under $(prefix) >>> * which might be insufficient. To complete the installation, >>> * "make install-distribution" should be executed. See README, >>> * "Notes for distributors" for details. >>> * NOTE: a plain "make install" installs only the files under $(prefix) >>> * which might be insufficient. To complete the installation, >>> * "make install-distribution" should be executed. See README, >>> * "Notes for distributors" for details. >>> XXXXXXXXXXXXXXX -- END RPM util-vserver Wed Feb 15 01:17:44 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM util-vserver-pl Wed Feb 15 01:17:44 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM util-vserver-pl Wed Feb 15 01:17:55 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM nodeupdate Wed Feb 15 01:17:55 CET 2017 >>> * Installing NodeUpdate node-side files >>> XXXXXXXXXXXXXXX -- END RPM nodeupdate Wed Feb 15 01:17:56 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM ipod Wed Feb 15 01:17:56 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM ipod Wed Feb 15 01:17:56 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM plnode-utils Wed Feb 15 01:17:56 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM plnode-utils Wed Feb 15 01:17:57 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM nodemanager Wed Feb 15 01:17:57 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM nodemanager Wed Feb 15 01:18:00 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM sshd Wed Feb 15 01:18:00 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM sshd Wed Feb 15 01:18:00 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM codemux Wed Feb 15 01:18:00 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM codemux Wed Feb 15 01:18:01 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM fprobe-ulog Wed Feb 15 01:18:01 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM fprobe-ulog Wed Feb 15 01:18:05 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM DistributedRateLimiting Wed Feb 15 01:18:05 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM DistributedRateLimiting Wed Feb 15 01:18:13 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM pf2slice Wed Feb 15 01:18:13 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM pf2slice Wed Feb 15 01:18:13 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM mom Wed Feb 15 01:18:13 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM mom Wed Feb 15 01:18:13 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM vsys Wed Feb 15 01:18:17 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM vsys Wed Feb 15 01:18:22 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM vsyssh Wed Feb 15 01:18:22 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM vsyssh Wed Feb 15 01:18:22 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM vsys-scripts Wed Feb 15 01:18:22 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM vsys-scripts Wed Feb 15 01:18:24 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM vsys-wrapper Wed Feb 15 01:18:24 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM vsys-wrapper Wed Feb 15 01:18:25 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM bind_public Wed Feb 15 01:18:25 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM bind_public Wed Feb 15 01:18:25 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM sliver-openvswitch Wed Feb 15 01:18:26 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM sliver-openvswitch Wed Feb 15 01:19:58 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM plcapi Wed Feb 15 01:19:58 CET 2017 >>> * Installing initscripts >>> * Installing db-config.d files >>> * Installing wsdl >>> XXXXXXXXXXXXXXX -- END RPM plcapi Wed Feb 15 01:20:02 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM drupal Wed Feb 15 01:20:02 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM drupal Wed Feb 15 01:20:03 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM plewww Wed Feb 15 01:20:03 CET 2017 >>> * PLEWWW: Installing web pages >>> * PLEWWW: Installing conf files for httpd >>> XXXXXXXXXXXXXXX -- END RPM plewww Wed Feb 15 01:20:06 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM www-register-wizard Wed Feb 15 01:20:06 CET 2017 >>> * www-register-wizard: Installing www-register-wizard pages >>> XXXXXXXXXXXXXXX -- END RPM www-register-wizard Wed Feb 15 01:20:07 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM pcucontrol Wed Feb 15 01:20:08 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM pcucontrol Wed Feb 15 01:20:38 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM monitor Wed Feb 15 01:20:43 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM monitor Wed Feb 15 01:21:02 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM plcrt Wed Feb 15 01:21:02 CET 2017 >>> * Installing core scripts >>> * Installing cron scripts >>> XXXXXXXXXXXXXXX -- END RPM plcrt Wed Feb 15 01:21:03 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM pyaspects Wed Feb 15 01:21:03 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM pyaspects Wed Feb 15 01:21:03 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM nodeconfig Wed Feb 15 01:21:03 CET 2017 >>> * nodeconfig: Installing PlanetLabConf pages >>> * Installing db-config.d files >>> XXXXXXXXXXXXXXX -- END RPM nodeconfig Wed Feb 15 01:21:04 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM bootmanager Wed Feb 15 01:21:04 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM bootmanager Wed Feb 15 01:21:05 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM pypcilib Wed Feb 15 01:21:05 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM pypcilib Wed Feb 15 01:21:06 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM pyplnet Wed Feb 15 01:21:07 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM pyplnet Wed Feb 15 01:21:07 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM bootcd Wed Feb 15 01:21:09 CET 2017 >>> * Creating fedora root image >>> * Entering pl_root_mkfedora /longbuildroot/BUILD/bootcd-onelab-f14-x86_64-5.4/bootcd/build/bootcd onelab ../build//config.planetlab/bootcd.pkgs >>> * candidate mirror http://mirror.onelab.eu/ >>> * Trying to fetch http://mirror.onelab.eu//fedora/releases/14/Everything/x86_64/os//repodata/repomd.xml >>> * Trying to fetch http://mirror.onelab.eu//fedora/updates/14/x86_64//repodata/repomd.xml >>> * Selected mirror http://mirror.onelab.eu/ >>> * Installing glibc >>> * Installing optional packages authconfig bash bind-utils btrfs-progs bzip2 coreutils curl dhclient diffutils dos2unix dosfstools e2fsprogs filesystem gnupg gzip hdparm iputils kbd kernel kexec-tools logrotate lsof lvm2 nano ncftp ntp openssh-clients openssh-server openvpn parted passwd pciutils pyparted pypcilib python python3 rsync rsyslog sharutils strace sudo tar tcpdump telnet time traceroute udev vconfig wget yum >>> * Install options /build/BUILD/bootcd-onelab-f14-x86_64-5.4/bootcd/build/bootcd -y -c /build/BUILD/bootcd-onelab-f14-x86_64-5.4/bootcd/build/bootcd/etc/mkfedora-yum.conf --installroot=/build/BUILD/bootcd-onelab-f14-x86_64-5.4/bootcd/build/bootcd --releasever=14 >>> * Removing unnecessary junk >>> * Cleaning up >>> * Installing IPMI utilities >>> * Installing initscripts >>> * Installing configuration files >>> * Tuning /etc/init/ for upstart >>> * Installing systemd files >>> * Configuration BootCD to start up pl_boot >>> * Enabling getty on tty2 >>> * Installing fallback node configuration file >>> * BootCD kernel (1) created from /longbuildroot/BUILD/bootcd-onelab-f14-x86_64-5.4/bootcd/build/bootcd/boot/vmlinuz-2.6.32-36.onelab.x86_64 >>> * Compressing reference image >>> XXXXXXXXXXXXXXX -- END RPM bootcd Wed Feb 15 01:23:37 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM sliceimage Wed Feb 15 01:23:37 CET 2017 >>> * Entering pl_root_mkfedora /longbuildroot/BUILD/sliceimage-onelab-f14-x86_64-5.1/sliceimage/vservers/.vref/onelab-f14-x86_64 onelab ../build//config.onelab/sliceimage.pkgs >>> * candidate mirror http://mirror.onelab.eu/ >>> * Trying to fetch http://mirror.onelab.eu//fedora/releases/14/Everything/x86_64/os//repodata/repomd.xml >>> * Trying to fetch http://mirror.onelab.eu//fedora/updates/14/x86_64//repodata/repomd.xml >>> * Selected mirror http://mirror.onelab.eu/ >>> * Installing glibc >>> * Installing optional packages bash bind_public bzip2 coreutils cronie crontabs curl dhclient diffutils filesystem findutils gzip ipfwslice iputils kernel-vserver logrotate nc openssh-clients passwd perl planetlab-umts-tools-frontend python python-devel python3 rsh rsync sliver-openvswitch sudo tar tcpdump telnet time traceroute vsys-wrapper vsyssh wget which yum >>> * Install options /build/BUILD/sliceimage-onelab-f14-x86_64-5.1/sliceimage/vservers/.vref/onelab-f14-x86_64 -y -c /build/BUILD/sliceimage-onelab-f14-x86_64-5.1/sliceimage/vservers/.vref/onelab-f14-x86_64/etc/mkfedora-yum.conf --installroot=/build/BUILD/sliceimage-onelab-f14-x86_64-5.1/sliceimage/vservers/.vref/onelab-f14-x86_64 --releasever=14 >>> * Warning: Missing packages >>> package kernel-vserver is not installed >>> * Cleaning up >>> * --------START BUILDING system sliceimage drl: Wed Feb 15 01:24:16 CET 2017 >>> * yum installing ulogd >>> * --------DONE BUILDING system sliceimage drl: Wed Feb 15 01:24:24 CET 2017 >>> * --------START BUILDING system sliceimage omf: Wed Feb 15 01:24:24 CET 2017 >>> * yum installing liboml >>> * WARNING image ../build/config.onelab/sliceimage-omf.pkgs - yum install liboml failed >>> * yum installing rvm-ruby >>> * WARNING image ../build/config.onelab/sliceimage-omf.pkgs - yum install rvm-ruby failed >>> * --------DONE BUILDING system sliceimage omf: Wed Feb 15 01:24:30 CET 2017 >>> * --------START BUILDING system sliceimage planetflow: Wed Feb 15 01:24:30 CET 2017 >>> * yum installing pf2slice >>> * yum installing rsync >>> * --------DONE BUILDING system sliceimage planetflow: Wed Feb 15 01:24:38 CET 2017 >>> * in slice image: resetting root password >>> * in slice image: removing requiretty from /etc/sudoers >>> * in slice image: fixing /etc/init.d/halt >>> * sliceimage.post: REMOVING empty /longbuildroot/BUILD/sliceimage-onelab-f14-x86_64-5.1/sliceimage/vservers/.vref/onelab-f14-x86_64/selinux >>> * sliceimage.post: rectifying fedora14 slice image with fedora-release-14-2.noarch.rpm >>> XXXXXXXXXXXXXXX -- END RPM sliceimage Wed Feb 15 01:25:57 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM vserver-sliceimage Wed Feb 15 01:25:57 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM vserver-sliceimage Wed Feb 15 01:25:57 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM nodeimage Wed Feb 15 01:25:58 CET 2017 >>> * Building nodeimage for onelab: Wed Feb 15 01:26:01 CET 2017 >>> * Entering pl_root_mkfedora /longbuildroot/BUILD/nodeimage-onelab-f14-x86_64-5.2/nodeimage/base onelab ../build//config.onelab/nodeimage.pkgs >>> * candidate mirror http://mirror.onelab.eu/ >>> * Trying to fetch http://mirror.onelab.eu//fedora/releases/14/Everything/x86_64/os//repodata/repomd.xml >>> * Trying to fetch http://mirror.onelab.eu//fedora/updates/14/x86_64//repodata/repomd.xml >>> * Selected mirror http://mirror.onelab.eu/ >>> * Installing glibc >>> * Installing optional packages NodeUpdate PyXML at authconfig basesystem bash bc bind-utils bzip2 codemux coreutils cpio cronie cronie-anacron crontabs curl dhclient diffutils dracut e2fsprogs ed emacs-nox ethtool expect file filesystem fprobe-ulog glibc gzip hdparm initscripts ipfwroot ipod iproute iptables iputils kbd kernel libnl logrotate lsof lvm2 madwifi mailcap monitor-client monitor-runlevelagent nano nc nfs-utils nodemanager-vs nrpe ntp openssh-clients openssh-server openvpn parted passwd pciutils perl pl_mom pl_sshd procps psacct pyplnet python python python3 quota readline rootfiles rpm rsh rsync rsyslog sendmail setserial setup shadow-utils sliceimage-onelab-f14-x86_64 sliceimage-system-onelab-f14-x86_64 sudo tar tcpdump telnet time tmpwatch traceroute udev util-linux-ng util-vserver util-vserver-build util-vserver-core util-vserver-legacy util-vserver-lib util-vserver-pl util-vserver-sysv vconfig vim-minimal vserver-sliceimage vsys vsys-scripts wget wireless-tools yum >>> * Install options /build/BUILD/nodeimage-onelab-f14-x86_64-5.2/nodeimage/base -y -c /build/BUILD/nodeimage-onelab-f14-x86_64-5.2/nodeimage/base/etc/mkfedora-yum.conf --installroot=/build/BUILD/nodeimage-onelab-f14-x86_64-5.2/nodeimage/base --releasever=14 >>> * Warning: Missing packages >>> package madwifi is not installed >>> * Cleaning up >>> * Handling onelab nodeimage extensions >>> * Start Building nodeimage-umts-f14-x86_64.tar.bz2: Wed Feb 15 01:27:23 CET 2017 >>> * tar nodeimage-umts-f14-x86_64.tar.bz2 s=01-27-34 m=01-27-34 e=01-27-39 >>> * Start Building nodeimage-wifi-f14-x86_64.tar.bz2: Wed Feb 15 01:27:39 CET 2017 >>> * tar nodeimage-wifi-f14-x86_64.tar.bz2 s=01-27-49 m=01-27-49 e=01-27-54 >>> * tar bootstrapfs-onelab-f14-x86_64.tar.bz2 s=01-27-54 m=01-27-55 e=01-29-16 >>> * Computed SHA1 checksum for bootstrapfs-onelab-f14-x86_64.tar (01-29-16OURCE .. 01-29-18OURCE) >>> * Computed SHA1 checksum for bootstrapfs-onelab-f14-x86_64.tar.bz2 (01-29-18OURCE .. 01-29-19OURCE) >>> * Handling NODEYUMEXCLUDE in yum repo for centos5/ (exclude=inotify-tools* iptables kernel kernel-debuginfo kernel-devel kernel-headers kernel-vserver libnl util-vserver*) >>> * Handling NODEYUMEXCLUDE in yum repo for centos6/ (exclude=) >>> * Handling NODEYUMEXCLUDE in yum repo for f14/ (exclude=iptables iptables-ipv6 kernel* util-vserver*) >>> * Handling NODEYUMEXCLUDE in yum repo for f18/ (exclude=) >>> * Handling NODEYUMEXCLUDE in yum repo for f20/ (exclude=) >>> * Handling NODEYUMEXCLUDE in yum repo for f21/ (exclude=) >>> * Handling NODEYUMEXCLUDE in yum repo for f22/ (exclude=) >>> * Handling NODEYUMEXCLUDE in yum repo for f23/ (exclude=) >>> * Handling NODEYUMEXCLUDE in yum repo for f24/ (exclude=) >>> * Handling NODEYUMEXCLUDE in yum repo for sl6/ (exclude=iptables kernel kernel-debug kernel-debug-devel kernel-devel kernel-doc kernel-firmware kernel-headers) >>> * nodeconfig/yum done 01-29-20OURCE >>> * Installing bootstrapfs-onelab-f14-x86_64.tar >>> * Installing bootstrapfs-onelab-f14-x86_64.tar.bz2 >>> * Installing bootstrapfs-onelab-f14-x86_64.tar.bz2.sha1sum >>> * Installing bootstrapfs-onelab-f14-x86_64.tar.sha1sum >>> * Installing MyPLC-side nodes yum config utilities (support for multi-fcdistro) >>> * Installing plc.d initscripts >>> * Installing db-config.d files >>> XXXXXXXXXXXXXXX -- END RPM nodeimage Wed Feb 15 01:33:17 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM noderepo Wed Feb 15 01:33:17 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM noderepo Wed Feb 15 01:33:35 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM slicerepo Wed Feb 15 01:33:35 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM slicerepo Wed Feb 15 01:33:42 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM myplc Wed Feb 15 01:33:43 CET 2017 >>> * Installing plc_config.py in >>> * Installing scripts in /usr/bin >>> * Installing plc initscript >>> * Installing plc.d initscripts >>> * Installing db-config.d files >>> * Installing scripts in /etc/support-scripts >>> * myplc: Installing configuration file >>> * Installing bashrc convenience >>> XXXXXXXXXXXXXXX -- END RPM myplc Wed Feb 15 01:33:52 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM myplc-docs Wed Feb 15 01:33:54 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM myplc-docs Wed Feb 15 01:34:17 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM release Wed Feb 15 01:34:17 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM release Wed Feb 15 01:34:17 CET 2017 >>> XXXXXXXXXXXXXXX -- BEG RPM sfa Wed Feb 15 01:34:19 CET 2017 >>> XXXXXXXXXXXXXXX -- END RPM sfa Wed Feb 15 01:34:45 CET 2017 >>> ==================== Within LXC END Wed Feb 15 01:34:51 CET 2017 >>> + echo '==================== Within LXC END Wed Feb 15 01:34:51 CET 2017' >>> + echo '============================== BEG lbuild-nightly.sh:run_log on Wed Feb 15 01:35:13 CET 2017' >>> ============================== BEG lbuild-nightly.sh:run_log on Wed Feb 15 01:35:13 CET 2017 >>> * 01:35:23 -- Checking if build provides SFA package... >>> * 01:35:23 -- build does provide SFA >>> * 01:35:39 -- PROVISION plc plctest1 in box buzzcocks at IP vplc14.pl.sophia.inria.fr as 2017.02.15--f14-1-vplc14 >>> * 01:35:49 -- PROVISION node node1 in box boxtops at IP vnode12 with MAC 02:34:56:00:00:12 >>> * 01:35:49 -- ********** 1 RUNNING step show on plc plctest1_vplc14 >>> * 01:35:49 -- ********** 1 SUCCESSFUL step show on plctest1_vplc14 >>> * 01:35:49 -- ********** 1 RUNNING step plcvm_delete on plc plctest1_vplc14 >>> * 01:35:51 -- ********** 1 SUCCESSFUL step plcvm_delete on plctest1_vplc14 >>> * 01:35:51 -- ********** 1 RUNNING step plcvm_timestamp on plc plctest1_vplc14 >>> * 01:35:52 -- ********** 1 SUCCESSFUL step plcvm_timestamp on plctest1_vplc14 >>> * 01:35:52 -- ********** 1 RUNNING step plcvm_create on plc plctest1_vplc14 >>> * 01:36:23 -- ********** 1 SUCCESSFUL step plcvm_create on plctest1_vplc14 >>> * 01:36:23 -- ********** 1 RUNNING step plc_install on plc plctest1_vplc14 >>> * 01:36:54 -- ********** 1 SUCCESSFUL step plc_install on plctest1_vplc14 >>> * 01:36:54 -- ********** 1 RUNNING step plc_configure on plc plctest1_vplc14 >>> * 01:36:55 -- ********** 1 SUCCESSFUL step plc_configure on plctest1_vplc14 >>> * 01:36:55 -- ********** 1 RUNNING step plc_start on plc plctest1_vplc14 >>> * 01:37:26 -- ********** 1 SUCCESSFUL step plc_start on plctest1_vplc14 >>> * 01:37:26 -- ********** 1 RUNNING step keys_fetch on plc plctest1_vplc14 >>> * 01:37:27 -- ********** 1 SUCCESSFUL step keys_fetch on plctest1_vplc14 >>> * 01:37:27 -- ********** 1 RUNNING step keys_store on plc plctest1_vplc14 >>> * 01:37:27 -- Storing key key_admin in keys/key_admin.pub >>> * 01:37:27 -- Storing key key_sfapi in keys/key_sfapi.pub >>> * 01:37:27 -- Storing key key_user in keys/key_user.pub >>> * 01:37:27 -- Storing key key_sfauser in keys/key_sfauser.pub >>> * 01:37:27 -- Storing key key_pi in keys/key_pi.pub >>> * 01:37:27 -- ********** 1 SUCCESSFUL step keys_store on plctest1_vplc14 >>> * 01:37:27 -- ********** 1 RUNNING step keys_clear_known_hosts on plc plctest1_vplc14 >>> * 01:37:27 -- Clearing entry for vnode12.pl.sophia.inria.fr in /root/.ssh/known_hosts >>> * 01:37:27 -- ********** 1 SUCCESSFUL step keys_clear_known_hosts on plctest1_vplc14 >>> * 01:37:27 -- ********** 1 RUNNING step plcapi_urls on plc plctest1_vplc14 >>> * 01:37:28 -- ********** 1 SUCCESSFUL step plcapi_urls on plctest1_vplc14 >>> * 01:37:28 -- ********** 1 RUNNING step speed_up_slices on plc plctest1_vplc14 >>> * 01:37:28 -- ********** 1 SUCCESSFUL step speed_up_slices on plctest1_vplc14 >>> * 01:37:28 -- ********** 1 RUNNING step initscripts on plc plctest1_vplc14 >>> * 01:37:29 -- ********** 1 SUCCESSFUL step initscripts on plctest1_vplc14 >>> * 01:37:29 -- ********** 1 RUNNING step sites on plc plctest1_vplc14 >>> * 01:37:29 -- Creating site inri & users in plctest1_vplc14.2017.02.15--f14-1-vplc14 >>> * 01:37:29 -- Adding user admin@onelab.eu - roles ['admin'] >>> * 01:37:29 -- Adding user fake-pi1@onelab.eu - roles ['pi'] >>> * 01:37:29 -- Adding user fake-pi2@onelab.eu - roles ['pi', 'tech'] >>> * 01:37:29 -- Adding user fake-tech1@onelab.eu - roles ['tech'] >>> * 01:37:29 -- Adding user fake-user1@onelab.eu - roles ['user'] >>> * 01:37:30 -- Adding user fake-tech2@onelab.eu - roles ['tech', 'user'] >>> * 01:37:30 -- ********** 1 SUCCESSFUL step sites on plctest1_vplc14 >>> * 01:37:30 -- ********** 1 RUNNING step nodes on plc plctest1_vplc14 >>> * 01:37:30 -- Creating nodes for site inri in plctest1_vplc14.2017.02.15--f14-1-vplc14 >>> * 01:37:30 -- node vnode12.pl.sophia.inria.fr created by user fake-pi1@onelab.eu >>> * 01:37:30 -- ********** 1 SUCCESSFUL step nodes on plctest1_vplc14 >>> * 01:37:30 -- ********** 1 RUNNING step slices on plc plctest1_vplc14 >>> * 01:37:30 -- Creating slice inri_sl1 >>> * 01:37:30 -- Adding initscript code #!/bin/bash >>> * 01:37:30 -- Adding ['vnode12.pl.sophia.inria.fr'] in inri_sl1 >>> * 01:37:30 -- Creating slice inri_sl2 >>> * 01:37:30 -- Adding initscript name initscript_by_name in inri_sl2 >>> * 01:37:31 -- Adding ['vnode12.pl.sophia.inria.fr'] in inri_sl2 >>> * 01:37:31 -- Creating slice inri_sl3 >>> * 01:37:31 -- Making slice inri_sl3 OMF-friendly >>> * 01:37:31 -- Adding ['vnode12.pl.sophia.inria.fr'] in inri_sl3 >>> * 01:37:31 -- ********** 1 SUCCESSFUL step slices on plctest1_vplc14 >>> * 01:37:31 -- ********** 1 RUNNING step nodegroups on plc plctest1_vplc14 >>> * 01:37:31 -- ********** 1 SUCCESSFUL step nodegroups on plctest1_vplc14 >>> * 01:37:31 -- ********** 1 RUNNING step leases on plc plctest1_vplc14 >>> * 01:37:31 -- No reservable node found - proceeding without leases >>> * 01:37:31 -- ********** 1 SUCCESSFUL step leases on plctest1_vplc14 >>> * 01:37:31 -- ********** 1 RUNNING step check_vsys_defaults_ignore on plc plctest1_vplc14 >>> * 01:37:31 -- ********** 1 IGNORED (OK) step check_vsys_defaults_ignore on plctest1_vplc14 >>> * 01:37:31 -- ********** 1 RUNNING step qemu_kill_mine on plc plctest1_vplc14 >>> * 01:37:31 -- Stopping qemu for node vnode12.pl.sophia.inria.fr on box boxtops >>> * 01:37:31 -- On boxtops: running qemu-vnode12.pl.sophia.inria.fr/qemu-kill-node vnode12.pl.sophia.inria.fr >>> * 01:37:32 -- ********** 1 SUCCESSFUL step qemu_kill_mine on plctest1_vplc14 >>> * 01:37:32 -- ********** 1 RUNNING step nodestate_reinstall on plc plctest1_vplc14 >>> * 01:37:32 -- ********** 1 SUCCESSFUL step nodestate_reinstall on plctest1_vplc14 >>> * 01:37:32 -- ********** 1 RUNNING step qemu_local_init on plc plctest1_vplc14 >>> * 01:37:32 -- ********** 1 SUCCESSFUL step qemu_local_init on plctest1_vplc14 >>> * 01:37:32 -- ********** 1 RUNNING step bootcd on plc plctest1_vplc14 >>> * 01:37:32 -- Calling GetBootMedium for vnode12.pl.sophia.inria.fr >>> * 01:37:35 -- Storing boot medium into qemu-vnode12.pl.sophia.inria.fr/vnode12.pl.sophia.inria.fr.iso >>> * 01:37:36 -- ********** 1 SUCCESSFUL step bootcd on plctest1_vplc14 >>> * 01:37:36 -- ********** 1 RUNNING step qemu_local_config on plc plctest1_vplc14 >>> * 01:37:36 -- Storing qemu config for vnode12.pl.sophia.inria.fr in qemu-vnode12.pl.sophia.inria.fr/qemu.conf >>> * 01:37:36 -- ********** 1 SUCCESSFUL step qemu_local_config on plctest1_vplc14 >>> * 01:37:36 -- ********** 1 RUNNING step qemu_clean_mine on plc plctest1_vplc14 >>> * 01:37:36 -- Cleaning up qemu for host vnode12.pl.sophia.inria.fr on box boxtops >>> * 01:37:36 -- ********** 1 SUCCESSFUL step qemu_clean_mine on plctest1_vplc14 >>> * 01:37:36 -- ********** 1 RUNNING step qemu_export on plc plctest1_vplc14 >>> * 01:37:36 -- Cleaning any former sequel of vnode12.pl.sophia.inria.fr on boxtops >>> * 01:37:36 -- Transferring configuration files for node vnode12.pl.sophia.inria.fr onto boxtops >>> * 01:37:38 -- ********** 1 SUCCESSFUL step qemu_export on plctest1_vplc14 >>> * 01:37:38 -- ********** 1 RUNNING step qemu_cleanlog on plc plctest1_vplc14 >>> * 01:37:38 -- On boxtops: running cd qemu-vnode12.pl.sophia.inria.fr; mv -f log.txt log.txt.bak >>> * 01:37:38 -- ********** 1 SUCCESSFUL step qemu_cleanlog on plctest1_vplc14 >>> * 01:37:38 -- ********** 1 RUNNING step qemu_start on plc plctest1_vplc14 >>> * 01:37:38 -- Starting qemu node vnode12.pl.sophia.inria.fr on boxtops >>> * 01:37:38 -- On boxtops: running qemu-vnode12.pl.sophia.inria.fr/qemu-bridge-init start >> qemu-vnode12.pl.sophia.inria.fr/log.txt >>> * 01:37:39 -- On boxtops: running qemu-vnode12.pl.sophia.inria.fr/qemu-start-node 2>&1 >> qemu-vnode12.pl.sophia.inria.fr/log.txt >>> * 01:37:39 -- ********** 1 SUCCESSFUL step qemu_start on plctest1_vplc14 >>> * 01:37:39 -- ********** 1 RUNNING step qemu_timestamp on plc plctest1_vplc14 >>> * 01:37:39 -- On boxtops: running mkdir -p qemu-vnode12.pl.sophia.inria.fr >>> * 01:37:40 -- On boxtops: running echo 1487119060 > qemu-vnode12.pl.sophia.inria.fr/timestamp >>> * 01:37:40 -- ********** 1 SUCCESSFUL step qemu_timestamp on plctest1_vplc14 >>> * 01:37:40 -- ********** 1 RUNNING step qemu_nodefamily on plc plctest1_vplc14 >>> * 01:37:40 -- On boxtops: running echo onelab-f14-x86_64 > qemu-vnode12.pl.sophia.inria.fr/nodefamily >>> * 01:37:41 -- ********** 1 SUCCESSFUL step qemu_nodefamily on plctest1_vplc14 >>> * 01:37:41 -- ********** 1 RUNNING step sfa_install_all on plc plctest1_vplc14 >>> * 01:37:47 -- ********** 1 SUCCESSFUL step sfa_install_all on plctest1_vplc14 >>> * 01:37:47 -- ********** 1 RUNNING step sfa_configure on plc plctest1_vplc14 >>> * 01:37:49 -- ********** 1 RUNNING step cross_sfa_configure on plc plctest1_vplc14 >>> * 01:37:49 -- ********** 1 SUCCESSFUL step cross_sfa_configure on plctest1_vplc14 >>> * 01:37:49 -- ********** 1 RUNNING step sfa_start on plc plctest1_vplc14 >>> * 01:37:54 -- ********** 1 SUCCESSFUL step sfa_start on plctest1_vplc14 >>> * 01:37:54 -- ********** 1 RUNNING step sfa_import on plc plctest1_vplc14 >>> * 01:37:57 -- ********** 1 SUCCESSFUL step sfa_import on plctest1_vplc14 >>> * 01:37:57 -- ********** 1 RUNNING step sfi_configure on plc plctest1_vplc14 >>> * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.pi-user.pkey >>> * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.pi-user.pub >>> * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.regular-user.pkey >>> * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/a.sfa.regular-user.pub >>> * 01:37:57 -- (Over)wrote conf.plctest1_vplc14/dot-sfi/sfi/sfi_config >>> * 01:37:58 -- ********** 1 SUCCESSFUL step sfi_configure on plctest1_vplc14 >>> * 01:37:58 -- ********** 1 RUNNING step sfa_register_site on plc plctest1_vplc14 >>> * 01:37:59 -- ********** 1 SUCCESSFUL step sfa_register_site on plctest1_vplc14 >>> * 01:37:59 -- ********** 1 RUNNING step sfa_register_pi on plc plctest1_vplc14 >>> * 01:38:02 -- ********** 1 SUCCESSFUL step sfa_register_pi on plctest1_vplc14 >>> * 01:38:02 -- ********** 1 RUNNING step sfa_register_user on plc plctest1_vplc14 >>> * 01:38:03 -- ********** 1 FAILED step sfa_register_user on plctest1_vplc14 (discarded from further steps) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_update_user on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_register_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_renew_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_remove_user_from_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfi_show_slice_researchers on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_insert_user_in_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfi_show_slice_researchers on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_discover on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_rspec on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_allocate on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_provision on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_describe on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_check_slice_plc on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_update_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfi_list on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfi_show_site on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_utest on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step probe_kvm_iptables on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ping_node on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ssh_node_debug on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step plcsh_stress_test on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ssh_node_boot on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step node_bmlogs on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_basics on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step check_initscripts on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_sfa on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_rspec_empty on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_allocate_empty on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_provision_empty on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_check_slice_plc_empty on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_delete_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step sfa_delete_user on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step cross_check_tcp on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step check_system_slice on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step debug_nodemanager on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step empty_slices on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_off on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step slice_fs_deleted_ignore on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step fill_slices on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 SKIPPED Step ssh_slice_again on plctest1_vplc14 (has failed sfa_register_user) >>> * 01:38:03 -- ********** 1 RUNNING step gather_logs (forced after sfa_register_user has failed) on plc plctest1_vplc14 >>> * 01:38:06 -- ********** 1 SUCCESSFUL step gather_logs on plctest1_vplc14 >>> + echo '============================== END lbuild-nightly.sh:run_log on Wed Feb 15 01:38:08 CET 2017' >>> ============================== END lbuild-nightly.sh:run_log on Wed Feb 15 01:38:08 CET 2017 ******************** END SUMMARY