(Reading database ... 69185 files and directories currently installed.)
Removing autopkgtest-satdep (0) ...
autopkgtest [05:56:46]: test integration: [-----------------------
Added user ubuntu.
Running commmand in testbed: /home/gvfs-testbed-script 

(udisksd:8087): udisks-WARNING **: 05:56:48.447: The --no-debug option is deprecated and ignored. See '--help'.
udisks-Message: 05:56:48.450: udisks daemon version 2.7.6 starting

** (udisksd:8087): WARNING **: 05:56:48.459: Failed to load config files: Failed to get contents of the config dir (/etc/libblockdev/conf.d/)Error opening directory ?/etc/libblockdev/conf.d/?: No such file or directory. Using the built-in config

** (udisksd:8087): WARNING **: 05:56:48.459: failed to load module crypto: libbd_crypto.so.2: cannot open shared object file: No such file or directory

** (udisksd:8087): WARNING **: 05:56:48.459: failed to load module mdraid: libbd_mdraid.so.2: cannot open shared object file: No such file or directory

(udisksd:8087): udisks-WARNING **: 05:56:48.461: Failed to load the 'mdraid' libblockdev plugin

(udisksd:8087): udisks-WARNING **: 05:56:48.461: Failed to load the 'crypto' libblockdev plugin

(udisksd:8087): udisks-WARNING **: 05:56:48.463: Can't load configuration file /etc/udisks2/udisks2.conf
udisks-Message: 05:56:48.527: Acquired the name org.freedesktop.UDisks2 on the system message bus
test_api (__main__.ArchiveMounter)
archive:// with Gio API ... ok
test_iso_joliet (__main__.ArchiveMounter)
archive:// for Joliet .iso ... ok
test_iso_rr (__main__.ArchiveMounter)
archive:// for RockRidge .iso ... ok
test_tar (__main__.ArchiveMounter)
archive:// for tar ... ok
test_tar_bz2 (__main__.ArchiveMounter)
archive:// for tar.bz2 ... ok
test_tar_gz (__main__.ArchiveMounter)
archive:// for tar.gz ... ok
test_zip (__main__.ArchiveMounter)
archive:// for .zip ... ok
test_http_auth (__main__.Dav)
dav://localhost with credentials ... ok
test_http_noauth (__main__.Dav)
dav://localhost without credentials ... ok
test_https_auth (__main__.Dav)
davs://localhost with credentials ... ok
test_https_noauth (__main__.Dav)
davs://localhost without credentials ... ok
test_cdrom (__main__.Drive)
drive mount: cdrom ... 
(udisksd:8087): udisks-WARNING **: 05:57:02.538: Failed to setup systemd-based mount point cleanup: Process reported exit code 5: Failed to start clean-mount-point@media-ubuntu-bogus\x2dcd.service: Unit media-ubuntu-bogus\x2dcd.mount not found.

udisks-Message: 05:57:02.538: Mounted /dev/sr0 at /media/ubuntu/bogus-cd on behalf of uid 1000
udisks-Message: 05:57:03.105: Cleaning up mount point /media/ubuntu/bogus-cd (device 11:0 is not mounted)
udisks-Message: 05:57:03.113: Unmounted /dev/sr0 on behalf of uid 1000
ok
test_cdrom_api (__main__.Drive)
drive mount: cdrom with Gio API ... 
(udisksd:8087): udisks-WARNING **: 05:57:04.717: Failed to setup systemd-based mount point cleanup: Process reported exit code 5: Failed to start clean-mount-point@media-ubuntu-bogus\x2dcd.service: Unit media-ubuntu-bogus\x2dcd.mount not found.

udisks-Message: 05:57:04.717: Mounted /dev/sr0 at /media/ubuntu/bogus-cd on behalf of uid 1000
udisks-Message: 05:57:04.726: Cleaning up mount point /media/ubuntu/bogus-cd (device 11:0 is not mounted)
udisks-Message: 05:57:04.733: Unmounted /dev/sr0 on behalf of uid 1000
ok
test_media_player (__main__.Drive)
drive mount: media player ... 
(udisksd:8087): udisks-WARNING **: 05:57:06.061: Failed to setup systemd-based mount point cleanup: Process reported exit code 5: Failed to start clean-mount-point@media-ubuntu-bogus\x2dcd.service: Unit media-ubuntu-bogus\x2dcd.mount not found.

udisks-Message: 05:57:06.061: Mounted /dev/sda at /media/ubuntu/bogus-cd on behalf of uid 1000
udisks-Message: 05:57:06.628: Cleaning up mount point /media/ubuntu/bogus-cd (device 8:0 is not mounted)
udisks-Message: 05:57:06.636: Unmounted /dev/sda on behalf of uid 1000
ok
test_system_partition (__main__.Drive)
drive mount: system partition ... 
(udisksd:8087): udisks-WARNING **: 05:57:08.853: Failed to setup systemd-based mount point cleanup: Process reported exit code 5: Failed to start clean-mount-point@media-ubuntu-testvfat.service: Unit media-ubuntu-testvfat.mount not found.

udisks-Message: 05:57:08.853: Mounted /dev/sda at /media/ubuntu/testvfat on behalf of uid 1000
udisks-Message: 05:57:09.421: Cleaning up mount point /media/ubuntu/testvfat (device 8:0 is not mounted)
udisks-Message: 05:57:09.432: Unmounted /dev/sda on behalf of uid 1000
ok
test_system_partition_api (__main__.Drive)
drive mount: system partition with Gio API ... ok
test_anonymous_api_flag (__main__.Ftp)
ftp:// anonymous (API with flag) ... ok
test_anonymous_api_user (__main__.Ftp)
ftp:// anonymous (API with user) ... FAIL

----- dbus stdout -----
ftp: Added new job source 0x10016009080 (GVfsBackendFtp)
ftp: Queued new job 0x10015fdef30 (GVfsJobMount)
ftp: <- 0 --  220 Twisted 17.9.0 FTP Server
ftp: -- 0 ->  FEAT
ftp: <- 0 --  211-Features:
ftp: <- 0 --   FEAT
ftp: <- 0 --   MDTM
ftp: <- 0 --   PASV
ftp: <- 0 --   SIZE
ftp: <- 0 --   TYPE A;I
ftp: <- 0 --  211 End
ftp: # feature MDTM supported
ftp: # feature SIZE supported
ftp: -- 0 ->  USER anonymous
ftp: <- 0 --  331 Guest login ok, type your email address as password.
ftp: -- 0 ->  PASS ***
ftp: <- 0 --  230 Anonymous login ok, access restrictions apply.
ftp: -- 0 ->  TYPE I
ftp: <- 0 --  200 Type set to I.
ftp: -- 0 ->  SYST
ftp: <- 0 --  215 UNIX Type: L8
ftp: # system is Unix
ftp: -- 0 ->  SITE HELP
ftp: <- 0 --  502 Command 'SITE' not implemented
ftp: -- 0 ->  PWD
ftp: <- 0 --  257 "/"
ftp: # warning: filename didn't contain space after final quote
ftp: send_reply(0x10015fdef30), failed=0 ()
ftp: backend_dbus_handler org.gtk.vfs.Mount:QueryInfo (pid=8092)
ftp: Queued new job 0x10015ff0200 (GVfsJobQueryInfo)
ftp: send_reply(0x10015ff0200), failed=0 ()
ftp: backend_dbus_handler org.gtk.vfs.Mount:Enumerate (pid=8092)
ftp: Queued new job 0x100160040f0 (GVfsJobEnumerate)
ftp: -- 0 ->  CWD /
ftp: <- 0 --  250 Requested File Action Completed OK
ftp: -- 0 ->  PASV
ftp: <- 0 --  227 Entering Passive Mode (127,0,0,1,168,5).
ftp: # set default data connection method from any to PASV
ftp: -- 0 ->  LIST -a
ftp: <- 0 --  125 Data connection already open, starting transfer
ftp: << 0 <<  drwxrwxr-x   2 ubuntu    ubuntu               4096 Mar 18 05:57 mydir
ftp: << 0 <<  -rw-rw-r--   1 ubuntu    ubuntu                 12 Mar 18 05:57 myfile.txt
ftp: <- 0 --  226 Transfer Complete.
ftp: send_reply(0x100160040f0), failed=0 ()
ftp: backend_dbus_handler org.gtk.vfs.Mount:OpenForRead (pid=8092)
ftp: Queued new job 0x10015ff02a0 (GVfsJobOpenForRead)
ftp: -- 0 ->  PASV
ftp: <- 0 --  227 Entering Passive Mode (127,0,0,1,162,125).
ftp: -- 0 ->  RETR //myfile.txt
ftp: <- 0 --  125 Data connection already open, starting transfer
ftp: send_reply(0x10015ff02a0), failed=0 ()
ftp: Added new job source 0x71d0740710c0 (GVfsReadChannel)
ftp: Queued new job 0x10015fdf470 (GVfsJobRead)
ftp: send_reply(0x10015fdf470), bytes=12, failed=0 ()
ftp: Queued new job 0x10015fdf500 (GVfsJobRead)
ftp: send_reply(0x10015fdf500), bytes=0, failed=0 ()
ftp: Queued new job 0x10015fdf590 (GVfsJobQueryInfoRead)
ftp: Queued new job 0x10015fd2210 (GVfsJobCloseRead)
ftp: <- 0 --  226 Transfer Complete.
ftp: send_reply(0x10015fd2210), failed=0 ()
ftp: backend_dbus_handler org.gtk.vfs.Mount:Unmount (pid=8092)
ftp: g_vfs_job_unmount_new request: 0x71d08402adf0
ftp: Queued new job 0x10015fdf740 (GVfsJobUnmount)
ftp: send_reply(0x10015fdf740), failed=1 (File system is busy)
ftp: send_reply(0x10015fdf740), failed=1 (File system is busy)

----- dbus stderr -----


test_anonymous_cli_option (__main__.Ftp)
ftp:// anonymous (CLI with option) ... ok
test_anonymous_cli_user (__main__.Ftp)
ftp:// anonymous (CLI with user) ... gio: ftp://anonymous@localhost:2121/: Location is already mounted
ERROR

----- dbus stdout -----

----- dbus stderr -----


test_authenticated_api (__main__.Ftp)
ftp:// authenticated (API) ... ok
test_authenticated_cli (__main__.Ftp)
ftp:// authenticated (CLI) ... ok
test_mount_api (__main__.GPhoto)
gphoto2:// mount with Gio API ... skipped 'umockdev/ioctl recording is currently known to have issue and not to be reworked'
test_rsa (__main__.Sftp)
sftp://localhost with RSA authentication ... ok
test_unknown_host (__main__.Sftp)
sftp:// with RSA authentication for unknown host ... ok
test_anonymous (__main__.Smb)
smb:// anonymous ... ok
test_authenticated (__main__.Smb)
smb:// authenticated ... ok
test_deletion_with_same_path (__main__.Trash)
trash:// deletion of two files with the same path ... ok
test_file_in_home_api (__main__.Trash)
trash:// deletion, attributes, restoring for a file in $HOME (API) ... ok
test_file_in_home_cli (__main__.Trash)
trash:// deletion, attributes, restoring for a file in $HOME (CLI) ... ok
test_file_in_system (__main__.Trash)
trash:// deletion for system location ... Traceback (most recent call last):
  File "/home/gvfs-testbed-script", line 272, in unmount_done
    success = obj.unmount_with_operation_finish(result)
GLib.Error: g-io-error-quark: File system is busy (26)
ok

======================================================================
ERROR: test_anonymous_cli_user (__main__.Ftp)
ftp:// anonymous (CLI with user)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "/home/gvfs-testbed-script", line 601, in test_anonymous_cli_user
    subprocess.check_call(['gio', 'mount', uri])
  File "/usr/lib/python3.6/subprocess.py", line 291, in check_call
    raise CalledProcessError(retcode, cmd)
subprocess.CalledProcessError: Command '['gio', 'mount', 'ftp://anonymous@localhost:2121']' returned non-zero exit status 2.

======================================================================
FAIL: test_anonymous_api_user (__main__.Ftp)
ftp:// anonymous (API with user)
----------------------------------------------------------------------
Traceback (most recent call last):
  File "/home/gvfs-testbed-script", line 676, in test_anonymous_api_user
    self.unmount_api(gfile)
  File "/home/gvfs-testbed-script", line 287, in unmount_api
    self.assertNotEqual(self.cb_result, None, 'operation timed out')
AssertionError: None == None : operation timed out

----------------------------------------------------------------------
Ran 31 tests in 36.935s

FAILED (failures=1, errors=1, skipped=1)
=== command failed, showing Samba log files ===
--- /var/log/samba/log.nmbd ---
[2018/03/18 05:56:48.299446,  0] ../lib/util/become_daemon.c:135(daemon_status)
  STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ...NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6).
--- /var/log/samba/log.smbd ---
[2018/03/18 05:56:48.367133,  0] ../lib/util/become_daemon.c:124(daemon_ready)
  STATUS=daemon 'smbd' finished starting up and ready to serve connections
autopkgtest [05:57:25]: test integration: -----------------------]
autopkgtest [05:57:26]: test integration:  - - - - - - - - - - results - - - - - - - - - -
integration          FAIL non-zero exit status 1
autopkgtest [05:57:26]: @@@@@@@@@@@@@@@@@@@@ summary
integration          FAIL non-zero exit status 1
Exit request sent.
Creating nova instance adt-bionic-ppc64el-gvfs-20180318-055334 from image ubuntu/ubuntu-bionic-adt-ppc64el-server-20180318.img (UUID 07ecef49-f8bd-4b52-ad63-eaa6f044ef30)...
