runtests.py-23975 Fri Jan  5 15:46:47 2018 UTC (+ 0.7s / 1079.4s) target /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/.config/akonadi/akonadiserverrc:
[%General]
Driver=QSQLITE3

[QSQLITE3]
Name=/data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/akonadi.db

[Debug]
Tracer=null

runtests.py-23975 Fri Jan  5 15:46:48 2018 UTC (+ 0.4s / 1079.8s) target /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/.local/share/akonadi/akonadi.db:
PRAGMA foreign_keys=OFF;
BEGIN TRANSACTION;
CREATE TABLE SchemaVersionTable (version INTEGER NOT NULL DEFAULT 0);
INSERT INTO "SchemaVersionTable" VALUES(20);
CREATE TABLE ResourceTable (id INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, name TEXT UNIQUE NOT NULL, isVirtual BOOL DEFAULT false);
INSERT INTO "ResourceTable" VALUES(1,'akonadi_search_resource',1);
INSERT INTO "ResourceTable" VALUES(2,'akonadi_ical_resource_0','false');
INSERT INTO "ResourceTable" VALUES(3,'akonadi_ical_resource_1','false');
INSERT INTO "ResourceTable" VALUES(4,'akonadi_ical_resource_2','false');
INSERT INTO "ResourceTable" VALUES(5,'akonadi_contacts_resource_0','false');
INSERT INTO "ResourceTable" VALUES(6,'akonadi_contacts_resource_1','false');
INSERT INTO "ResourceTable" VALUES(7,'akonadi_contacts_resource_2','false');
INSERT INTO "ResourceTable" VALUES(8,'akonadi_notes_resource_0','false');
INSERT INTO "ResourceTable" VALUES(9,'akonadi_notes_resource_1','false');
INSERT INTO "ResourceTable" VALUES(10,'akonadi_notes_resource_2','false');
CREATE TABLE CollectionTable (id INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, remoteId TEXT, remoteRevision TEXT, name TEXT NOT NULL, parentId BIGINT, resourceId BIGINT NOT NULL, subscribed BOOL NOT NULL DEFAULT true, cachePolicyInherit BOOL NOT NULL DEFAULT true, cachePolicyCheckInterval INTEGER NOT NULL DEFAULT -1, cachePolicyCacheTimeout INTEGER NOT NULL DEFAULT -1, cachePolicySyncOnDemand BOOL NOT NULL DEFAULT false, cachePolicyLocalParts TEXT, queryString TEXT, queryLanguage TEXT);
INSERT INTO "CollectionTable" VALUES(1,NULL,NULL,'Search',NULL,1,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(2,'file:///data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/ical_resource_0.ics','','akonadi_ical_resource_0',NULL,2,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(3,'file:///data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/ical_resource_1.ics','','akonadi_ical_resource_1',NULL,3,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(4,'file:///data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/ical_resource_2.ics','','akonadi_ical_resource_2',NULL,4,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(5,'/data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/contacts_0','','Personal_Contacts_0',NULL,5,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(6,'/data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/contacts_1','','Personal_Contacts_1',NULL,6,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(8,'/data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/contacts_2','','Personal_Contacts_2',NULL,7,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(9,'file:///data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/notes_resource_0.ics','','akonadi_notes_resource_0',NULL,8,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(10,'file:///data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/notes_resource_0.ics','','akonadi_notes_resource_1',NULL,9,'true','true',-1,-1,'false',NULL,NULL,NULL);
INSERT INTO "CollectionTable" VALUES(11,'file:///data/runtests/work/downstream-unstable/home/memotoo/data/akonadi/notes_resource_1.ics','','akonadi_notes_resource_2',NULL,10,'true','true',-1,-1,'false',NULL,NULL,NULL);
CREATE TABLE MimeTypeTable (id INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, name TEXT UNIQUE NOT NULL);
INSERT INTO "MimeTypeTable" VALUES(1,'application/octet-stream');
INSERT INTO "MimeTypeTable" VALUES(2,'message/rfc822');
INSERT INTO "MimeTypeTable" VALUES(3,'text/calendar');
INSERT INTO "MimeTypeTable" VALUES(4,'text/vcard');
INSERT INTO "MimeTypeTable" VALUES(5,'inode/directory');
INSERT INTO "MimeTypeTable" VALUES(6,'application/x-vnd.akonadi.calendar.event');
INSERT INTO "MimeTypeTable" VALUES(7,'application/x-vnd.akonadi.calendar.todo');
INSERT INTO "MimeTypeTable" VALUES(8,'application/x-vnd.akonadi.calendar.journal');
INSERT INTO "MimeTypeTable" VALUES(9,'application/x-vnd.akonadi.calendar.freebusy');
INSERT INTO "MimeTypeTable" VALUES(10,'text/directory');
INSERT INTO "MimeTypeTable" VALUES(11,'application/x-vnd.kde.contactgroup');
INSERT INTO "MimeTypeTable" VALUES(12,'application/x-vnd.kde.notes');
CREATE TABLE PimItemTable (id INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, rev INTEGER NOT NULL DEFAULT 0, remoteId TEXT, remoteRevision TEXT, collectionId BIGINT, mimeTypeId BIGINT, datetime TIMESTAMP DEFAULT CURRENT_TIMESTAMP, atime TIMESTAMP, dirty BOOL, size BIGINT NOT NULL DEFAULT 0);
CREATE TABLE FlagTable (id INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, name TEXT UNIQUE NOT NULL);
INSERT INTO "FlagTable" VALUES(1,'important');
INSERT INTO "FlagTable" VALUES(2,'has_attachment');
INSERT INTO "FlagTable" VALUES(3,'spam');
INSERT INTO "FlagTable" VALUES(4,'\ANSWERED');
INSERT INTO "FlagTable" VALUES(5,'\FLAGGED');
INSERT INTO "FlagTable" VALUES(6,'\DELETED');
INSERT INTO "FlagTable" VALUES(7,'\SEEN');
INSERT INTO "FlagTable" VALUES(8,'\DRAFT');
CREATE TABLE PartTable (id INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, pimItemId BIGINT NOT NULL, name TEXT NOT NULL, data LONGBLOB, datasize BIGINT NOT NULL, version INTEGER DEFAULT 0, external BOOL DEFAULT false);
CREATE TABLE CollectionAttributeTable (id INTEGER PRIMARY KEY AUTOINCREMENT NOT NULL, collectionId BIGINT NOT NULL, type LONGBLOB NOT NULL, value LONGBLOB);
INSERT INTO "CollectionAttributeTable" VALUES(1,2,X'454E54495459444953504C4159',X'28226963616C5F7265736F757263655F302E6963732220226F66666963652D63616C656E6461722220222220282929');
INSERT INTO "CollectionAttributeTable" VALUES(2,2,X'416363657373526967687473',X'77636457');
INSERT INTO "CollectionAttributeTable" VALUES(3,3,X'454E54495459444953504C4159',X'28226963616C5F7265736F757263655F302E6963732028436C6F6E65292220226F66666963652D63616C656E6461722220222220282929');
INSERT INTO "CollectionAttributeTable" VALUES(4,3,X'416363657373526967687473',X'77636457');
INSERT INTO "CollectionAttributeTable" VALUES(5,4,X'454E54495459444953504C4159',X'28226963616C5F7265736F757263655F322E6963732220226F66666963652D63616C656E6461722220222220282929');
INSERT INTO "CollectionAttributeTable" VALUES(6,4,X'416363657373526967687473',X'77636457');
INSERT INTO "CollectionAttributeTable" VALUES(7,5,X'416363657373526967687473',X'61');
INSERT INTO "CollectionAttributeTable" VALUES(8,6,X'416363657373526967687473',X'61');
INSERT INTO "CollectionAttributeTable" VALUES(10,8,X'416363657373526967687473',X'61');
INSERT INTO "CollectionAttributeTable" VALUES(11,9,X'454E54495459444953504C4159',X'28226E6F7465735F7265736F757263655F302E6963732220226B6E6F7465732220222220282929');
INSERT INTO "CollectionAttributeTable" VALUES(12,9,X'416363657373526967687473',X'77636457');
INSERT INTO "CollectionAttributeTable" VALUES(13,10,X'454E54495459444953504C4159',X'28226E6F7465735F7265736F757263655F302E6963732028436C6F6E65292220226B6E6F7465732220222220282929');
INSERT INTO "CollectionAttributeTable" VALUES(14,10,X'416363657373526967687473',X'77636457');
INSERT INTO "CollectionAttributeTable" VALUES(15,11,X'454E54495459444953504C4159',X'28226E6F7465735F7265736F757263655F302E6963732028436C6F6E65292028436C6F6E65292220226B6E6F7465732220222220282929');
INSERT INTO "CollectionAttributeTable" VALUES(16,11,X'416363657373526967687473',X'77636457');
CREATE TABLE PimItemFlagRelation (PimItem_id INTEGER REFERENCES PimItemTable(id), Flag_id INTEGER REFERENCES FlagTable(id), PRIMARY KEY (PimItem_id, Flag_id));
CREATE TABLE CollectionMimeTypeRelation (Collection_id INTEGER REFERENCES CollectionTable(id), MimeType_id INTEGER REFERENCES MimeTypeTable(id), PRIMARY KEY (Collection_id, MimeType_id));
INSERT INTO "CollectionMimeTypeRelation" VALUES(2,3);
INSERT INTO "CollectionMimeTypeRelation" VALUES(2,6);
INSERT INTO "CollectionMimeTypeRelation" VALUES(2,7);
INSERT INTO "CollectionMimeTypeRelation" VALUES(2,8);
INSERT INTO "CollectionMimeTypeRelation" VALUES(2,9);
INSERT INTO "CollectionMimeTypeRelation" VALUES(3,6);
INSERT INTO "CollectionMimeTypeRelation" VALUES(3,9);
INSERT INTO "CollectionMimeTypeRelation" VALUES(3,8);
INSERT INTO "CollectionMimeTypeRelation" VALUES(3,7);
INSERT INTO "CollectionMimeTypeRelation" VALUES(3,3);
INSERT INTO "CollectionMimeTypeRelation" VALUES(4,6);
INSERT INTO "CollectionMimeTypeRelation" VALUES(4,9);
INSERT INTO "CollectionMimeTypeRelation" VALUES(4,8);
INSERT INTO "CollectionMimeTypeRelation" VALUES(4,7);
INSERT INTO "CollectionMimeTypeRelation" VALUES(4,3);
INSERT INTO "CollectionMimeTypeRelation" VALUES(5,5);
INSERT INTO "CollectionMimeTypeRelation" VALUES(5,10);
INSERT INTO "CollectionMimeTypeRelation" VALUES(5,11);
INSERT INTO "CollectionMimeTypeRelation" VALUES(6,11);
INSERT INTO "CollectionMimeTypeRelation" VALUES(6,5);
INSERT INTO "CollectionMimeTypeRelation" VALUES(6,10);
INSERT INTO "CollectionMimeTypeRelation" VALUES(8,11);
INSERT INTO "CollectionMimeTypeRelation" VALUES(8,5);
INSERT INTO "CollectionMimeTypeRelation" VALUES(8,10);
INSERT INTO "CollectionMimeTypeRelation" VALUES(9,12);
INSERT INTO "CollectionMimeTypeRelation" VALUES(10,12);
INSERT INTO "CollectionMimeTypeRelation" VALUES(11,12);
CREATE TABLE CollectionPimItemRelation (Collection_id INTEGER REFERENCES CollectionTable(id), PimItem_id INTEGER REFERENCES PimItemTable(id), PRIMARY KEY (Collection_id, PimItem_id));
DELETE FROM sqlite_sequence;
INSERT INTO "sqlite_sequence" VALUES('ResourceTable',10);
INSERT INTO "sqlite_sequence" VALUES('CollectionTable',11);
INSERT INTO "sqlite_sequence" VALUES('MimeTypeTable',12);
INSERT INTO "sqlite_sequence" VALUES('FlagTable',8);
INSERT INTO "sqlite_sequence" VALUES('CollectionAttributeTable',16);
CREATE UNIQUE INDEX CollectionTable_parentAndNameIndex ON CollectionTable (parentId,name);
CREATE INDEX PimItemTable_collectionIndex ON PimItemTable (collectionId);
CREATE UNIQUE INDEX PartTable_pimItemIdNameIndex ON PartTable (pimItemId,name);
CREATE INDEX PartTable_pimItemNameIndex ON PartTable (name);
CREATE INDEX CollectionAttributeTable_collectionIndex ON CollectionAttributeTable (collectionId);
COMMIT;

old /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/.cache new /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/cache
old /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/.config new /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/config
old /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/.local/share new /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/home/memotoo/data
runtests.py-23975 Fri Jan  5 15:46:48 2018 UTC (+ 0.0s / 1079.8s) === starting memotoo ===
runtests.py-23975 Fri Jan  5 15:46:48 2018 UTC (+ 0.0s / 1079.8s) result dir: /data/schroot/2018-01-05-07-10-all-downstream-unstable/home/nightly/results/2018-01-05-07-10_all/downstream-unstable/39-memotoo, /proc/self/cwd -> /data/schroot/2018-01-05-07-10-all-downstream-unstable/home/nightly/results/2018-01-05-07-10_all/downstream-unstable/39-memotoo
runtests.py-23975 Fri Jan  5 15:46:48 2018 UTC (+ 0.0s / 1079.8s) changing into directory /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/tests/memotoo (= /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/tests/memotoo)
runtests.py-23975 Fri Jan  5 15:46:48 2018 UTC (+ 0.0s / 1079.8s) *** ( cd /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/tests/memotoo; export 'PATH=/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin' 'HOME=/data/runtests/work/downstream-unstable/home/memotoo' 'XDG_CONFIG_HOME=/data/runtests/work/downstream-unstable/home/memotoo/config' 'XDG_DATA_HOME=/data/runtests/work/downstream-unstable/home/memotoo/data' 'XDG_CACHE_HOME=/data/runtests/work/downstream-unstable/home/memotoo/cache'; unset LD_LIBRARY_PATH; /data/runtests/work/sources/syncevolution/test/resources.py -j 1 -r memotoo -- env CLIENT_TEST_MAY_COPY_BACK=1 CLIENT_TEST_NOCHECK_SYNCMODE=1 CLIENT_TEST_NUM_ITEMS=10 CLIENT_TEST_FAILURES=Client::Sync::.*eds_contact.*::testMerge, CLIENT_TEST_SKIP=Client::Sync::eds_event::testAddBothSides,Client::Sync::eds_event::testAddBothSidesRefresh,Client::Sync::eds_task::testAddBothSides,Client::Sync::eds_task::testAddBothSidesRefresh,Client::Sync::eds_contact::Retry,Client::Sync::eds_contact::Suspend,Client::Sync::eds_event::testRefreshFromClientSync,Client::Sync::eds_event::testRefreshFromClientSemantic,Client::Sync::eds_event::testOneWayFromServer,Client::Sync::eds_event::testDeleteAllRefresh,Client::Sync::eds_event::Retry,Client::Sync::eds_event::Suspend,Client::Sync::eds_task::testRefreshFromClientSync,Client::Sync::eds_task::testRefreshFromClientSemantic,Client::Sync::eds_task::testDeleteAllRefresh,Client::Sync::eds_task::testOneWayFromServer,Client::Sync::eds_task::Retry,Client::Sync::eds_task::Suspend,Client::Sync::eds_memo::testRefreshFromClientSync,Client::Sync::eds_memo::testRefreshFromClientSemantic,Client::Sync::eds_memo::testDeleteAllRefresh,Client::Sync::eds_memo::testOneWayFromServer,Client::Sync::eds_memo::Retry,Client::Sync::eds_memo::Suspend,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testRefreshFromClientSync,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testRefreshFromClientSemantic,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testDeleteAllRefresh,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testOneWayFromServer,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::Retry,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::Suspend,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testRefreshFromClientSync,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testRefreshFromClientSemantic,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testOneWayFromServer,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testDeleteAllRefresh,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::Retry,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::Suspend CLIENT_TEST_DELAY=10 CLIENT_TEST_RESEND_TIMEOUT=5 CLIENT_TEST_INTERRUPT_AT=1 SYNCEVOLUTION_DATA_DIR=/data/runtests/work/downstream-unstable/install/usr/share/syncevolution SYNCEVOLUTION_TEMPLATE_DIR=/data/runtests/work/downstream-unstable/install/usr/share/syncevolution/templates SYNCEVOLUTION_XML_CONFIG_DIR=/data/runtests/work/downstream-unstable/install/usr/share/syncevolution/xml SYNCEVOLUTION_BACKEND_DIR=/data/runtests/work/downstream-unstable/install/usr/lib/syncevolution/backends SYNCEVOLUTION_LOCALE_DIR=/data/runtests/work/downstream-unstable/install/usr/share/locale schroot -d /data/runtests/work/downstream-unstable/tests/memotoo -r -p -c 2018-01-05-07-10-all-downstream-unstable -- env PKG_CONFIG_PATH=/data/runtests/install/stable-amd64/libwbxml/lib/pkgconfig DBUS_SESSION_SH_SYSTEM_BUS=1 /unshare --pid --mount-proc --fork -- /data/runtests/work/sources/syncevolution/test/dbus-session.sh /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log dbus-monitor.log dbus-monitor interface=org.freedesktop.DBus -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env /home/nightly/testing/setup-syncevolution.sh memotoo ./syncevolution )
Fri Jan  5 15:46:48 2018 UTC (+ 0.0s / 0.0s) === locking resource(s) ['memotoo'] ===
Fri Jan  5 15:49:43 2018 UTC (+ 175.2s / 175.2s) property changed: status = acquired
Fri Jan  5 15:49:43 2018 UTC (+ 0.0s / 175.2s) using jobserver
Fri Jan  5 15:49:43 2018 UTC (+ 0.0s / 175.2s) === allocating 1 job slot(s) ===
Fri Jan  5 15:50:01 2018 UTC (+ 18.5s / 193.7s) === allocated 1 job slot(s) ===
W: line 4 [2018-01-05-07-10-all-release-eas-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-release-eas-stretch-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-xenial-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-clang-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-xenial-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-downstream-xenial-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-release-eas-stretch-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-testing-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-xenial-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-downstream-unstable] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-downstream-testing] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-release-eas-testing-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
I: [2018-01-05-07-10-all-downstream-unstable chroot] Running command: “env PKG_CONFIG_PATH=/data/runtests/install/stable-amd64/libwbxml/lib/pkgconfig DBUS_SESSION_SH_SYSTEM_BUS=1 /unshare --pid --mount-proc --fork -- /data/runtests/work/sources/syncevolution/test/dbus-session.sh /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log dbus-monitor.log dbus-monitor interface=org.freedesktop.DBus -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env /home/nightly/testing/setup-syncevolution.sh memotoo ./syncevolution”
gnome-keyring-daemon: insufficient process capabilities, unsecure memory might get used
** Message: couldn't access control socket: /tmp/tmp.Z0sn3Jty5l/keyring/control: No such file or directory
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-15 line 16: PIDS=
wrappercheck-15 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-15 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-15 line 21: DAEMON_LOG=
wrappercheck-15 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-15 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-15 line 25: declare -a BACKGROUND
wrappercheck-15 line 26: declare -a ENV
wrappercheck-15 line 28: '[' 32 -gt 1 ']'
wrappercheck-15 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-15 line 29: case "$1" in
wrappercheck-15 line 31: shift
wrappercheck-15 line 32: DAEMON_LOG=dbus-monitor.log
wrappercheck-15 line 53: shift
wrappercheck-15 line 28: '[' 30 -gt 1 ']'
wrappercheck-15 line 28: '[' dbus-monitor '!=' -- ']'
wrappercheck-15 line 29: case "$1" in
wrappercheck-15 line 50: break
wrappercheck-15 line 56: '[' 30 -gt 1 ']'
wrappercheck-15 line 56: '[' dbus-monitor '!=' -- ']'
wrappercheck-15 line 57: BACKGROUND[${#BACKGROUND[*]}]=dbus-monitor
wrappercheck-15 line 58: shift
wrappercheck-15 line 56: '[' 29 -gt 1 ']'
wrappercheck-15 line 56: '[' interface=org.freedesktop.DBus '!=' -- ']'
wrappercheck-15 line 57: BACKGROUND[${#BACKGROUND[*]}]=interface=org.freedesktop.DBus
wrappercheck-15 line 58: shift
wrappercheck-15 line 56: '[' 28 -gt 1 ']'
wrappercheck-15 line 56: '[' -- '!=' -- ']'
wrappercheck-15 line 60: shift
wrappercheck-15 line 62: '[' dbus-monitor.log ']'
wrappercheck-15 line 62: '[' '' ']'
wrappercheck-15 line 66: set +x
*** starting dbus-monitor as background daemon, output to dbus-monitor.log
wrappercheck-15 line 72: BACKGROUND_PID=18
wrappercheck-15 line 73: PIDS+=18
wrappercheck-15 line 70: set -x
wrappercheck-15 line 75: '[' dbus-monitor.log ']'
wrappercheck-15 line 75: '[' '' ']'
wrappercheck-15 line 70: exec
wrappercheck-15 line 84: '[' '' ']'
wrappercheck-15 line 93: kill -0 18
wrappercheck-15 line 94: set +e
wrappercheck-15 line 95: '[' '' ']'
wrappercheck-15 line 99: set -x
wrappercheck-15 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env /home/nightly/testing/setup-syncevolution.sh memotoo ./syncevolution
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-22 line 16: PIDS=
wrappercheck-22 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-22 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-22 line 21: DAEMON_LOG=
wrappercheck-22 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-22 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-22 line 25: declare -a BACKGROUND
wrappercheck-22 line 26: declare -a ENV
wrappercheck-22 line 28: '[' 26 -gt 1 ']'
wrappercheck-22 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-22 line 29: case "$1" in
wrappercheck-22 line 31: shift
wrappercheck-22 line 32: DAEMON_LOG=evolution-source-registry.log
wrappercheck-22 line 53: shift
wrappercheck-22 line 28: '[' 24 -gt 1 ']'
wrappercheck-22 line 28: '[' --daemon-sleep '!=' -- ']'
wrappercheck-22 line 29: case "$1" in
wrappercheck-22 line 43: shift
wrappercheck-22 line 44: DAEMON_SLEEP=5
wrappercheck-22 line 53: shift
wrappercheck-22 line 28: '[' 22 -gt 1 ']'
wrappercheck-22 line 28: '[' --wait-for-dbus-daemon '!=' -- ']'
wrappercheck-22 line 29: case "$1" in
wrappercheck-22 line 35: shift
wrappercheck-22 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.Sources
wrappercheck-22 line 53: shift
wrappercheck-22 line 28: '[' 20 -gt 1 ']'
wrappercheck-22 line 28: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']'
wrappercheck-22 line 29: case "$1" in
wrappercheck-22 line 50: break
wrappercheck-22 line 56: '[' 20 -gt 1 ']'
wrappercheck-22 line 56: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']'
wrappercheck-22 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-source-registry
wrappercheck-22 line 58: shift
wrappercheck-22 line 56: '[' 19 -gt 1 ']'
wrappercheck-22 line 56: '[' -- '!=' -- ']'
wrappercheck-22 line 60: shift
wrappercheck-22 line 62: '[' evolution-source-registry.log ']'
wrappercheck-22 line 62: '[' '' ']'
wrappercheck-22 line 66: set +x
*** starting /usr/lib/evolution/evolution-source-registry as background daemon, output to evolution-source-registry.log
wrappercheck-22 line 72: BACKGROUND_PID=26
wrappercheck-22 line 73: PIDS+=26
wrappercheck-22 line 75: '[' evolution-source-registry.log ']'
wrappercheck-22 line 75: '[' '' ']'
wrappercheck-22 line 84: '[' org.gnome.evolution.dataserver.Sources ']'
wrappercheck-22 line 85: set +x
*** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.Sources'
wrappercheck-22 line 70: set -x
wrappercheck-22 line 70: exec
wrappercheck-22 line 93: kill -0 26
wrappercheck-22 line 94: set +e
wrappercheck-22 line 95: '[' 5 ']'
wrappercheck-22 line 96: set +x
*** 'sleep 5' for daemon to settle down
wrappercheck-22 line 97: sleep 5
wrappercheck-22 line 99: set -x
wrappercheck-22 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env /home/nightly/testing/setup-syncevolution.sh memotoo ./syncevolution
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-79 line 16: PIDS=
wrappercheck-79 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-79 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-79 line 21: DAEMON_LOG=
wrappercheck-79 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-79 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-79 line 25: declare -a BACKGROUND
wrappercheck-79 line 26: declare -a ENV
wrappercheck-79 line 28: '[' 17 -gt 1 ']'
wrappercheck-79 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-79 line 29: case "$1" in
wrappercheck-79 line 31: shift
wrappercheck-79 line 32: DAEMON_LOG=evolution-addressbook-factory.log
wrappercheck-79 line 53: shift
wrappercheck-79 line 28: '[' 15 -gt 1 ']'
wrappercheck-79 line 28: '[' --wait-for-dbus-daemon '!=' -- ']'
wrappercheck-79 line 29: case "$1" in
wrappercheck-79 line 35: shift
wrappercheck-79 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.AddressBook
wrappercheck-79 line 53: shift
wrappercheck-79 line 28: '[' 13 -gt 1 ']'
wrappercheck-79 line 28: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-79 line 29: case "$1" in
wrappercheck-79 line 50: break
wrappercheck-79 line 56: '[' 13 -gt 1 ']'
wrappercheck-79 line 56: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-79 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-addressbook-factory
wrappercheck-79 line 58: shift
wrappercheck-79 line 56: '[' 12 -gt 1 ']'
wrappercheck-79 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-79 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-79 line 58: shift
wrappercheck-79 line 56: '[' 11 -gt 1 ']'
wrappercheck-79 line 56: '[' -- '!=' -- ']'
wrappercheck-79 line 60: shift
wrappercheck-79 line 62: '[' evolution-addressbook-factory.log ']'
wrappercheck-79 line 62: '[' '' ']'
wrappercheck-79 line 66: set +x
*** starting /usr/lib/evolution/evolution-addressbook-factory as background daemon, output to evolution-addressbook-factory.log
wrappercheck-79 line 72: BACKGROUND_PID=81
wrappercheck-79 line 73: PIDS+=81
wrappercheck-79 line 75: '[' evolution-addressbook-factory.log ']'
wrappercheck-79 line 75: '[' '' ']'
wrappercheck-79 line 84: '[' org.gnome.evolution.dataserver.AddressBook ']'
wrappercheck-79 line 70: set -x
wrappercheck-79 line 70: exec
wrappercheck-79 line 85: set +x
*** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.AddressBook'
wrappercheck-79 line 93: kill -0 81
wrappercheck-79 line 94: set +e
wrappercheck-79 line 95: '[' '' ']'
wrappercheck-79 line 99: set -x
wrappercheck-79 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env /home/nightly/testing/setup-syncevolution.sh memotoo ./syncevolution
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-99 line 16: PIDS=
wrappercheck-99 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-99 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-99 line 21: DAEMON_LOG=
wrappercheck-99 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-99 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-99 line 25: declare -a BACKGROUND
wrappercheck-99 line 26: declare -a ENV
wrappercheck-99 line 28: '[' 9 -gt 1 ']'
wrappercheck-99 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-99 line 29: case "$1" in
wrappercheck-99 line 31: shift
wrappercheck-99 line 32: DAEMON_LOG=evolution-calendar-factory.log
wrappercheck-99 line 53: shift
wrappercheck-99 line 28: '[' 7 -gt 1 ']'
wrappercheck-99 line 28: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-99 line 29: case "$1" in
wrappercheck-99 line 50: break
wrappercheck-99 line 56: '[' 7 -gt 1 ']'
wrappercheck-99 line 56: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-99 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-calendar-factory
wrappercheck-99 line 58: shift
wrappercheck-99 line 56: '[' 6 -gt 1 ']'
wrappercheck-99 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-99 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-99 line 58: shift
wrappercheck-99 line 56: '[' 5 -gt 1 ']'
wrappercheck-99 line 56: '[' -- '!=' -- ']'
wrappercheck-99 line 60: shift
wrappercheck-99 line 62: '[' evolution-calendar-factory.log ']'
wrappercheck-99 line 62: '[' '' ']'
wrappercheck-99 line 66: set +x
*** starting /usr/lib/evolution/evolution-calendar-factory as background daemon, output to evolution-calendar-factory.log
wrappercheck-99 line 72: BACKGROUND_PID=101
wrappercheck-99 line 73: PIDS+=101
wrappercheck-99 line 75: '[' evolution-calendar-factory.log ']'
wrappercheck-99 line 75: '[' '' ']'
wrappercheck-99 line 84: '[' '' ']'
wrappercheck-99 line 93: kill -0 101
wrappercheck-99 line 94: set +e
wrappercheck-99 line 95: '[' '' ']'
wrappercheck-99 line 99: set -x
wrappercheck-99 line 99: env /home/nightly/testing/setup-syncevolution.sh memotoo ./syncevolution
wrappercheck-99 line 70: set -x
wrappercheck-99 line 70: exec
+ case $TEST in
+ rm -rf '/data/runtests/work/downstream-unstable/home/memotoo/.sync4j/evolution/memotoo_[12]' '/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/memotoo_[12]' '/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-[12]/peers/memotoo_[12]' '/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-[12]'
+ for client in 1 2
+ ./syncevolution --version
+ grep -q -e '[+ ]1.[0-9]'
+ config=memotoo_1@client-test-memotoo-1
++ credentials memotoo_1
++ case "$SCHROOT_CHROOT_NAME" in
++ case $1 in
++ echo '--sync-property DeviceId=sc-api-A --sync-property username=syncevolution --sync-property password=ss9dkaft4n --sync-property preventSlowSync=0 --sync-property syncURL=http://www.memotoo.com/syncmldev --sync-property enableWBXML=0 --sync-property loglevel=6'
+ ./syncevolution --daemon=no --configure --template memotoo --sync-property DeviceId=sc-api-A --sync-property username=syncevolution --sync-property password=ss9dkaft4n --sync-property preventSlowSync=0 --sync-property syncURL=http://www.memotoo.com/syncmldev --sync-property enableWBXML=0 --sync-property loglevel=6 --sync-property proxyHost=http://proxy.vlan13.01.org:3128 --sync-property useProxy=0 --sync-property logLevel=4 memotoo_1@client-test-memotoo-1
[INFO] addressbook: checking usability...
[INFO] addressbook: configuring datastore with sync mode 'two-way'
[INFO] calendar: checking usability...
[INFO] calendar: configuring datastore with sync mode 'two-way'
[INFO] memo: checking usability...
[INFO] memo: configuring datastore with sync mode 'two-way'
[INFO] todo: checking usability...
[INFO] todo: configuring datastore with sync mode 'two-way'
+ sources=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources addressbook eds_contact
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources
+ shift
+ source=addressbook
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/addressbook ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/addressbook /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/eds_contact
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources calendar eds_event
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources
+ shift
+ source=calendar
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/calendar ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/calendar /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/eds_event
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources todo eds_task
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources
+ shift
+ source=todo
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/todo ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/todo /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/eds_task
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources memo eds_memo
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources
+ shift
+ source=memo
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/memo ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/memo /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-1/peers/memotoo_1/sources/eds_memo
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_contact_1 memotoo_1@client-test-memotoo-1 eds_contact
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_event_1 memotoo_1@client-test-memotoo-1 eds_event
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_task_1 memotoo_1@client-test-memotoo-1 eds_task
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_memo_1 memotoo_1@client-test-memotoo-1 eds_memo
+ case $TEST in
+ case $TEST in
+ case $TEST in
+ for client in 1 2
+ ./syncevolution --version
+ grep -q -e '[+ ]1.[0-9]'
+ config=memotoo_2@client-test-memotoo-2
++ credentials memotoo_2
++ case "$SCHROOT_CHROOT_NAME" in
++ case $1 in
++ echo '--sync-property DeviceId=sc-pim-B --sync-property username=syncevolution --sync-property password=ss9dkaft4n --sync-property preventSlowSync=0 --sync-property syncURL=http://www.memotoo.com/syncmldev --sync-property enableWBXML=0 --sync-property loglevel=6'
+ ./syncevolution --daemon=no --configure --template memotoo --sync-property DeviceId=sc-pim-B --sync-property username=syncevolution --sync-property password=ss9dkaft4n --sync-property preventSlowSync=0 --sync-property syncURL=http://www.memotoo.com/syncmldev --sync-property enableWBXML=0 --sync-property loglevel=6 --sync-property proxyHost=http://proxy.vlan13.01.org:3128 --sync-property useProxy=0 --sync-property logLevel=4 memotoo_2@client-test-memotoo-2
[INFO] addressbook: checking usability...
[INFO] addressbook: configuring datastore with sync mode 'two-way'
[INFO] calendar: checking usability...
[INFO] calendar: configuring datastore with sync mode 'two-way'
[INFO] memo: checking usability...
[INFO] memo: configuring datastore with sync mode 'two-way'
[INFO] todo: checking usability...
[INFO] todo: configuring datastore with sync mode 'two-way'

** (gnome-keyring-daemon:14): WARNING **: asked to register item /org/freedesktop/secrets/collection/default/8, but it's already registered
+ sources=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources addressbook eds_contact
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources
+ shift
+ source=addressbook
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/addressbook ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/addressbook /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/eds_contact
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources calendar eds_event
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources
+ shift
+ source=calendar
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/calendar ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/calendar /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/eds_event
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources todo eds_task
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources
+ shift
+ source=todo
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/todo ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/todo /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/eds_task
+ copy_source /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources memo eds_memo
+ path=/data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources
+ shift
+ source=memo
+ shift
+ '[' -d /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/memo ']'
+ for i in $@
+ cp -r /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/memo /data/runtests/work/downstream-unstable/home/memotoo/config/syncevolution/client-test-memotoo-2/peers/memotoo_2/sources/eds_memo
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_contact_2 memotoo_2@client-test-memotoo-2 eds_contact
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_event_2 memotoo_2@client-test-memotoo-2 eds_event
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_task_2 memotoo_2@client-test-memotoo-2 eds_task
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_memo_2 memotoo_2@client-test-memotoo-2 eds_memo
+ case $TEST in
+ case $TEST in
+ case $TEST in
+ case $TEST in
+ for i in evolution-contacts=eds_contact evolution-calendar=eds_event evolution-tasks=eds_task evolution-memos=eds_memo
++ echo evolution-contacts=eds_contact
++ sed -e 's/=.*//'
+ backend=evolution-contacts
++ echo evolution-contacts=eds_contact
++ sed -e 's/.*=//'
+ name=eds_contact
+ for i in 1 2
+ databasename=Test_eds_contact_1
+ grep Test_eds_contact_1
+ ./syncevolution --daemon=no --print-databases backend=evolution-contacts
   Test_eds_contact_1 (1303826927.6946.21@mob-sync2)
+ echo evolution-contacts: Test_eds_contact_1 exists
evolution-contacts: Test_eds_contact_1 exists
+ for i in 1 2
+ databasename=Test_eds_contact_2
+ grep Test_eds_contact_2
+ ./syncevolution --daemon=no --print-databases backend=evolution-contacts
   Test_eds_contact_2 (1303827279.6946.22@mob-sync2)
+ echo evolution-contacts: Test_eds_contact_2 exists
evolution-contacts: Test_eds_contact_2 exists
+ for i in evolution-contacts=eds_contact evolution-calendar=eds_event evolution-tasks=eds_task evolution-memos=eds_memo
++ echo evolution-calendar=eds_event
++ sed -e 's/=.*//'
+ backend=evolution-calendar
++ sed -e 's/.*=//'
++ echo evolution-calendar=eds_event
+ name=eds_event
+ for i in 1 2
+ databasename=Test_eds_event_1
+ grep Test_eds_event_1
+ ./syncevolution --daemon=no --print-databases backend=evolution-calendar
   Test_eds_event_1 (1303827939.6946.27@mob-sync2)
+ echo evolution-calendar: Test_eds_event_1 exists
evolution-calendar: Test_eds_event_1 exists
+ for i in 1 2
+ databasename=Test_eds_event_2
+ ./syncevolution --daemon=no --print-databases backend=evolution-calendar
+ grep Test_eds_event_2
   Test_eds_event_2 (1303827982.6946.28@mob-sync2)
+ echo evolution-calendar: Test_eds_event_2 exists
evolution-calendar: Test_eds_event_2 exists
+ for i in evolution-contacts=eds_contact evolution-calendar=eds_event evolution-tasks=eds_task evolution-memos=eds_memo
++ sed -e 's/=.*//'
++ echo evolution-tasks=eds_task
+ backend=evolution-tasks
++ sed -e 's/.*=//'
++ echo evolution-tasks=eds_task
+ name=eds_task
+ for i in 1 2
+ databasename=Test_eds_task_1
+ ./syncevolution --daemon=no --print-databases backend=evolution-tasks
+ grep Test_eds_task_1
   Test_eds_task_1 (1303829357.6946.35@mob-sync2)
+ echo evolution-tasks: Test_eds_task_1 exists
evolution-tasks: Test_eds_task_1 exists
+ for i in 1 2
+ databasename=Test_eds_task_2
+ ./syncevolution --daemon=no --print-databases backend=evolution-tasks
+ grep Test_eds_task_2
   Test_eds_task_2 (1303829493.6946.36@mob-sync2)
+ echo evolution-tasks: Test_eds_task_2 exists
evolution-tasks: Test_eds_task_2 exists
+ for i in evolution-contacts=eds_contact evolution-calendar=eds_event evolution-tasks=eds_task evolution-memos=eds_memo
++ sed -e 's/=.*//'
++ echo evolution-memos=eds_memo
+ backend=evolution-memos
++ sed -e 's/.*=//'
++ echo evolution-memos=eds_memo
+ name=eds_memo
+ for i in 1 2
+ databasename=Test_eds_memo_1
+ ./syncevolution --daemon=no --print-databases backend=evolution-memos
+ grep Test_eds_memo_1
   Test_eds_memo_1 (1303828148.6946.31@mob-sync2)
+ echo evolution-memos: Test_eds_memo_1 exists
evolution-memos: Test_eds_memo_1 exists
+ for i in 1 2
+ databasename=Test_eds_memo_2
+ grep Test_eds_memo_2
+ ./syncevolution --daemon=no --print-databases backend=evolution-memos
   Test_eds_memo_2 (1303828749.6946.32@mob-sync2)
+ echo evolution-memos: Test_eds_memo_2 exists
evolution-memos: Test_eds_memo_2 exists
wrappercheck-99 line 100: RET=0
wrappercheck-99 line 101: set -e
wrappercheck-99 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-calendar-factory
wrappercheck-99 line 108: kill -INT -101
wrappercheck-99 line 108: kill -TERM -101
wrappercheck-99 line 108: kill -TERM 101
wrappercheck-99 line 110: KILL_PID=770
wrappercheck-99 line 115: set +e
wrappercheck-99 line 116: wait 101
wrappercheck-99 line 109: perl -e 'sleep(60); kill(9, -101);'
wrappercheck-99 line 117: SUBRET=143
wrappercheck-99 line 118: case $SUBRET in
wrappercheck-99 line 118: SUBRET=0
wrappercheck-99 line 120: SUBRET=0
wrappercheck-99 line 121: '[' 770 ']'
wwrappercheck-99 line 122: LC_ALL=C
wwrappercheck-99 line 122: kill -KILL 770
wrappercheck-99 line 122: msg=
wrappercheck-99 line 123: echo ''
wrappercheck-99 line 123: grep -q 'No such process'
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   770 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-99 line 127: echo ''

wrappercheck-99 line 129: wait 770
wrappercheck-99 line 131: set -e
wrappercheck-99 line 132: '[' 0 = 0 ']'
wrappercheck-99 line 133: RET=0
wrappercheck-99 line 136: exit 0
wrappercheck-79 line 100: RET=0
wrappercheck-79 line 101: set -e
wrappercheck-79 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-addressbook-factory
wrappercheck-79 line 108: kill -INT -81
wrappercheck-79 line 108: kill -TERM -81
wrappercheck-79 line 108: kill -TERM 81
wrappercheck-79 line 110: KILL_PID=775
wrappercheck-79 line 115: set +e
wrappercheck-79 line 109: perl -e 'sleep(60); kill(9, -81);'
wrappercheck-79 line 116: wait 81
wrappercheck-79 line 117: SUBRET=143
wrappercheck-79 line 118: case $SUBRET in
wrappercheck-79 line 118: SUBRET=0
wrappercheck-79 line 120: SUBRET=0
wrappercheck-79 line 121: '[' 775 ']'
wwrappercheck-79 line 122: LC_ALL=C
wwrappercheck-79 line 122: kill -KILL 775
wrappercheck-79 line 122: msg=
wrappercheck-79 line 123: grep -q 'No such process'
wrappercheck-79 line 123: echo ''
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   775 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-79 line 127: echo ''

wrappercheck-79 line 129: wait 775
wrappercheck-79 line 131: set -e
wrappercheck-79 line 132: '[' 0 = 0 ']'
wrappercheck-79 line 133: RET=0
wrappercheck-79 line 136: exit 0
wrappercheck-22 line 100: RET=0
wrappercheck-22 line 101: set -e
wrappercheck-22 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-source-registry
wrappercheck-22 line 108: kill -INT -26
wrappercheck-22 line 108: kill -TERM -26
wrappercheck-22 line 108: kill -TERM 26
wrappercheck-22 line 110: KILL_PID=780
wrappercheck-22 line 115: set +e
wrappercheck-22 line 116: wait 26
wrappercheck-22 line 117: SUBRET=143
wrappercheck-22 line 118: case $SUBRET in
wrappercheck-22 line 118: SUBRET=0
wrappercheck-22 line 120: SUBRET=0
wrappercheck-22 line 121: '[' 780 ']'
wrappercheck-22 line 109: perl -e 'sleep(60); kill(9, -26);'
wwrappercheck-22 line 122: LC_ALL=C
wwrappercheck-22 line 122: kill -KILL 780
wrappercheck-22 line 122: msg=
wrappercheck-22 line 123: grep -q 'No such process'
wrappercheck-22 line 123: echo ''
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   780 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-22 line 127: echo ''

wrappercheck-22 line 129: wait 780
wrappercheck-22 line 131: set -e
wrappercheck-22 line 132: '[' 0 = 0 ']'
wrappercheck-22 line 133: RET=0
wrappercheck-22 line 136: exit 0
wrappercheck-15 line 100: RET=0
wrappercheck-15 line 101: set -e
wrappercheck-15 line 107: set +x
*** killing and waiting for dbus-monitor
wrappercheck-15 line 108: kill -INT -18
wrappercheck-15 line 108: kill -TERM -18
wrappercheck-15 line 108: kill -TERM 18
wrappercheck-15 line 110: KILL_PID=785
wrappercheck-15 line 115: set +e
wrappercheck-15 line 116: wait 18
wrappercheck-15 line 109: perl -e 'sleep(60); kill(9, -18);'
wrappercheck-15 line 117: SUBRET=143
wrappercheck-15 line 118: case $SUBRET in
wrappercheck-15 line 118: SUBRET=0
wrappercheck-15 line 120: SUBRET=0
wrappercheck-15 line 121: '[' 785 ']'
wwrappercheck-15 line 122: LC_ALL=C
wwrappercheck-15 line 122: kill -KILL 785
wrappercheck-15 line 122: msg=
wrappercheck-15 line 123: echo ''
wrappercheck-15 line 123: grep -q 'No such process'
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   785 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-15 line 127: echo ''

wrappercheck-15 line 129: wait 785
wrappercheck-15 line 131: set -e
wrappercheck-15 line 132: '[' 0 = 0 ']'
wrappercheck-15 line 133: RET=0
wrappercheck-15 line 136: exit 0
dbus-session.sh: program returned 0
dbus-session.sh: final result 0
dbus-session.sh 1: killing keyring pid 14
dbus-session.sh 1: killing system bus daemon 4
dbus-session.sh 1: killing session bus daemon 8
dbus-session.sh 1: removing XDG_RUNTIME_DIR=/tmp/tmp.Z0sn3Jty5l
Fri Jan  5 15:50:13 2018 UTC (+ 11.7s / 205.4s) === cleaning up ===
runtests.py-23975 Fri Jan  5 15:50:13 2018 UTC (+ 205.4s / 1285.2s) *** ( cd /data/schroot/2018-01-05-07-10-all-downstream-unstable/data/runtests/work/downstream-unstable/tests/memotoo; export 'PATH=/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin' 'HOME=/data/runtests/work/downstream-unstable/home/memotoo' 'XDG_CONFIG_HOME=/data/runtests/work/downstream-unstable/home/memotoo/config' 'XDG_DATA_HOME=/data/runtests/work/downstream-unstable/home/memotoo/data' 'XDG_CACHE_HOME=/data/runtests/work/downstream-unstable/home/memotoo/cache'; unset LD_LIBRARY_PATH; /data/runtests/work/sources/syncevolution/test/resources.py -j 1 -r memotoo -- env http_proxy= CLIENT_TEST_SERVER=memotoo CLIENT_TEST_SOURCES=eds_contact,eds_event,eds_task,eds_memo SYNC_EVOLUTION_EVO_CALENDAR_DELAY=1 CLIENT_TEST_ALARM=1200 CLIENT_TEST_MAY_COPY_BACK=1 CLIENT_TEST_NOCHECK_SYNCMODE=1 CLIENT_TEST_NUM_ITEMS=10 CLIENT_TEST_FAILURES=Client::Sync::.*eds_contact.*::testMerge, CLIENT_TEST_SKIP=Client::Sync::eds_event::testAddBothSides,Client::Sync::eds_event::testAddBothSidesRefresh,Client::Sync::eds_task::testAddBothSides,Client::Sync::eds_task::testAddBothSidesRefresh,Client::Sync::eds_contact::Retry,Client::Sync::eds_contact::Suspend,Client::Sync::eds_event::testRefreshFromClientSync,Client::Sync::eds_event::testRefreshFromClientSemantic,Client::Sync::eds_event::testOneWayFromServer,Client::Sync::eds_event::testDeleteAllRefresh,Client::Sync::eds_event::Retry,Client::Sync::eds_event::Suspend,Client::Sync::eds_task::testRefreshFromClientSync,Client::Sync::eds_task::testRefreshFromClientSemantic,Client::Sync::eds_task::testDeleteAllRefresh,Client::Sync::eds_task::testOneWayFromServer,Client::Sync::eds_task::Retry,Client::Sync::eds_task::Suspend,Client::Sync::eds_memo::testRefreshFromClientSync,Client::Sync::eds_memo::testRefreshFromClientSemantic,Client::Sync::eds_memo::testDeleteAllRefresh,Client::Sync::eds_memo::testOneWayFromServer,Client::Sync::eds_memo::Retry,Client::Sync::eds_memo::Suspend,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testRefreshFromClientSync,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testRefreshFromClientSemantic,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testDeleteAllRefresh,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::testOneWayFromServer,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::Retry,Client::Sync::eds_contact_eds_event_eds_task_eds_memo::Suspend,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testRefreshFromClientSync,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testRefreshFromClientSemantic,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testOneWayFromServer,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::testDeleteAllRefresh,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::Retry,Client::Sync::eds_event_eds_task_eds_memo_eds_contact::Suspend CLIENT_TEST_DELAY=10 CLIENT_TEST_RESEND_TIMEOUT=5 CLIENT_TEST_INTERRUPT_AT=1 SYNCEVOLUTION_DATA_DIR=/data/runtests/work/downstream-unstable/install/usr/share/syncevolution SYNCEVOLUTION_TEMPLATE_DIR=/data/runtests/work/downstream-unstable/install/usr/share/syncevolution/templates SYNCEVOLUTION_XML_CONFIG_DIR=/data/runtests/work/downstream-unstable/install/usr/share/syncevolution/xml SYNCEVOLUTION_BACKEND_DIR=/data/runtests/work/downstream-unstable/install/usr/lib/syncevolution/backends SYNCEVOLUTION_LOCALE_DIR=/data/runtests/work/downstream-unstable/install/usr/share/locale CLIENT_TEST_LOG= CLIENT_TEST_EVOLUTION_PREFIX=Test_ schroot -d /data/runtests/work/downstream-unstable/tests/memotoo -r -p -c 2018-01-05-07-10-all-downstream-unstable -- env PKG_CONFIG_PATH=/data/runtests/install/stable-amd64/libwbxml/lib/pkgconfig DBUS_SESSION_SH_SYSTEM_BUS=1 /unshare --pid --mount-proc --fork -- /data/runtests/work/sources/syncevolution/test/dbus-session.sh /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log dbus-monitor.log dbus-monitor interface=org.freedesktop.DBus -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:$PATH: ./client-test Client::Sync::eds_contact::testItems )
Fri Jan  5 15:50:13 2018 UTC (+ 0.0s / 0.0s) === locking resource(s) ['memotoo'] ===
Fri Jan  5 15:51:15 2018 UTC (+ 62.1s / 62.1s) property changed: status = acquired
Fri Jan  5 15:51:15 2018 UTC (+ 0.0s / 62.1s) using jobserver
Fri Jan  5 15:51:15 2018 UTC (+ 0.0s / 62.1s) === allocating 1 job slot(s) ===
Fri Jan  5 16:12:12 2018 UTC (+ 1256.7s / 1318.9s) === allocated 1 job slot(s) ===
W: line 4 [2018-01-05-07-10-all-release-eas-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-release-eas-stretch-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-xenial-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-clang-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-xenial-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-downstream-xenial-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-release-eas-stretch-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-testing-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-xenial-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-downstream-unstable] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-downstream-testing] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-release-eas-testing-i386] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
I: [2018-01-05-07-10-all-downstream-unstable chroot] Running command: “env PKG_CONFIG_PATH=/data/runtests/install/stable-amd64/libwbxml/lib/pkgconfig DBUS_SESSION_SH_SYSTEM_BUS=1 /unshare --pid --mount-proc --fork -- /data/runtests/work/sources/syncevolution/test/dbus-session.sh /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log dbus-monitor.log dbus-monitor interface=org.freedesktop.DBus -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: ./client-test Client::Sync::eds_contact::testItems”
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-15 line 16: PIDS=
wrappercheck-15 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-15 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-15 line 21: DAEMON_LOG=
wrappercheck-15 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-15 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-15 line 25: declare -a BACKGROUND
wrappercheck-15 line 26: declare -a ENV
wrappercheck-15 line 28: '[' 33 -gt 1 ']'
wrappercheck-15 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-15 line 29: case "$1" in
wrappercheck-15 line 31: shift
wrappercheck-15 line 32: DAEMON_LOG=dbus-monitor.log
wrappercheck-15 line 53: shift
wrappercheck-15 line 28: '[' 31 -gt 1 ']'
wrappercheck-15 line 28: '[' dbus-monitor '!=' -- ']'
wrappercheck-15 line 29: case "$1" in
wrappercheck-15 line 50: break
wrappercheck-15 line 56: '[' 31 -gt 1 ']'
wrappercheck-15 line 56: '[' dbus-monitor '!=' -- ']'
wrappercheck-15 line 57: BACKGROUND[${#BACKGROUND[*]}]=dbus-monitor
wrappercheck-15 line 58: shift
wrappercheck-15 line 56: '[' 30 -gt 1 ']'
wrappercheck-15 line 56: '[' interface=org.freedesktop.DBus '!=' -- ']'
wrappercheck-15 line 57: BACKGROUND[${#BACKGROUND[*]}]=interface=org.freedesktop.DBus
wrappercheck-15 line 58: shift
wrappercheck-15 line 56: '[' 29 -gt 1 ']'
wrappercheck-15 line 56: '[' -- '!=' -- ']'
wrappercheck-15 line 60: shift
wrappercheck-15 line 62: '[' dbus-monitor.log ']'
wrappercheck-15 line 62: '[' '' ']'
wrappercheck-15 line 66: set +x
*** starting dbus-monitor as background daemon, output to dbus-monitor.log
wrappercheck-15 line 72: BACKGROUND_PID=17
wrappercheck-15 line 73: PIDS+=17
wrappercheck-15 line 70: set -x
wrappercheck-15 line 70: exec
wrappercheck-15 line 75: '[' dbus-monitor.log ']'
wrappercheck-15 line 75: '[' '' ']'
wrappercheck-15 line 84: '[' '' ']'
wrappercheck-15 line 93: kill -0 17
gnome-keyring-daemon: insufficient process capabilities, unsecure memory might get used
wrappercheck-15 line 94: set +e
wrappercheck-15 line 95: '[' '' ']'
wrappercheck-15 line 99: set -x
wrappercheck-15 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: ./client-test Client::Sync::eds_contact::testItems
** Message: couldn't access control socket: /tmp/tmp.DQo742F4CV/keyring/control: No such file or directory
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-20 line 16: PIDS=
wrappercheck-20 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-20 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-20 line 21: DAEMON_LOG=
wrappercheck-20 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-20 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-20 line 25: declare -a BACKGROUND
wrappercheck-20 line 26: declare -a ENV
wrappercheck-20 line 28: '[' 27 -gt 1 ']'
wrappercheck-20 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-20 line 29: case "$1" in
wrappercheck-20 line 31: shift
wrappercheck-20 line 32: DAEMON_LOG=evolution-source-registry.log
wrappercheck-20 line 53: shift
wrappercheck-20 line 28: '[' 25 -gt 1 ']'
wrappercheck-20 line 28: '[' --daemon-sleep '!=' -- ']'
wrappercheck-20 line 29: case "$1" in
wrappercheck-20 line 43: shift
wrappercheck-20 line 44: DAEMON_SLEEP=5
wrappercheck-20 line 53: shift
wrappercheck-20 line 28: '[' 23 -gt 1 ']'
wrappercheck-20 line 28: '[' --wait-for-dbus-daemon '!=' -- ']'
wrappercheck-20 line 29: case "$1" in
wrappercheck-20 line 35: shift
wrappercheck-20 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.Sources
wrappercheck-20 line 53: shift
wrappercheck-20 line 28: '[' 21 -gt 1 ']'
wrappercheck-20 line 28: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']'
wrappercheck-20 line 29: case "$1" in
wrappercheck-20 line 50: break
wrappercheck-20 line 56: '[' 21 -gt 1 ']'
wrappercheck-20 line 56: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']'
wrappercheck-20 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-source-registry
wrappercheck-20 line 58: shift
wrappercheck-20 line 56: '[' 20 -gt 1 ']'
wrappercheck-20 line 56: '[' -- '!=' -- ']'
wrappercheck-20 line 60: shift
wrappercheck-20 line 62: '[' evolution-source-registry.log ']'
wrappercheck-20 line 62: '[' '' ']'
wrappercheck-20 line 66: set +x
*** starting /usr/lib/evolution/evolution-source-registry as background daemon, output to evolution-source-registry.log
wrappercheck-20 line 72: BACKGROUND_PID=26
wrappercheck-20 line 73: PIDS+=26
wrappercheck-20 line 70: set -x
wrappercheck-20 line 75: '[' evolution-source-registry.log ']'
wrappercheck-20 line 75: '[' '' ']'
wrappercheck-20 line 70: exec
wrappercheck-20 line 84: '[' org.gnome.evolution.dataserver.Sources ']'
wrappercheck-20 line 85: set +x
*** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.Sources'
wrappercheck-20 line 93: kill -0 26
wrappercheck-20 line 94: set +e
wrappercheck-20 line 95: '[' 5 ']'
wrappercheck-20 line 96: set +x
*** 'sleep 5' for daemon to settle down
wrappercheck-20 line 97: sleep 5
wrappercheck-20 line 99: set -x
wrappercheck-20 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: ./client-test Client::Sync::eds_contact::testItems
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-79 line 16: PIDS=
wrappercheck-79 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-79 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-79 line 21: DAEMON_LOG=
wrappercheck-79 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-79 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-79 line 25: declare -a BACKGROUND
wrappercheck-79 line 26: declare -a ENV
wrappercheck-79 line 28: '[' 18 -gt 1 ']'
wrappercheck-79 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-79 line 29: case "$1" in
wrappercheck-79 line 31: shift
wrappercheck-79 line 32: DAEMON_LOG=evolution-addressbook-factory.log
wrappercheck-79 line 53: shift
wrappercheck-79 line 28: '[' 16 -gt 1 ']'
wrappercheck-79 line 28: '[' --wait-for-dbus-daemon '!=' -- ']'
wrappercheck-79 line 29: case "$1" in
wrappercheck-79 line 35: shift
wrappercheck-79 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.AddressBook
wrappercheck-79 line 53: shift
wrappercheck-79 line 28: '[' 14 -gt 1 ']'
wrappercheck-79 line 28: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-79 line 29: case "$1" in
wrappercheck-79 line 50: break
wrappercheck-79 line 56: '[' 14 -gt 1 ']'
wrappercheck-79 line 56: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-79 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-addressbook-factory
wrappercheck-79 line 58: shift
wrappercheck-79 line 56: '[' 13 -gt 1 ']'
wrappercheck-79 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-79 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-79 line 58: shift
wrappercheck-79 line 56: '[' 12 -gt 1 ']'
wrappercheck-79 line 56: '[' -- '!=' -- ']'
wrappercheck-79 line 60: shift
wrappercheck-79 line 62: '[' evolution-addressbook-factory.log ']'
wrappercheck-79 line 62: '[' '' ']'
wrappercheck-79 line 66: set +x
*** starting /usr/lib/evolution/evolution-addressbook-factory as background daemon, output to evolution-addressbook-factory.log
wrappercheck-79 line 72: BACKGROUND_PID=81
wrappercheck-79 line 73: PIDS+=81
wrappercheck-79 line 75: '[' evolution-addressbook-factory.log ']'
wrappercheck-79 line 70: set -x
wrappercheck-79 line 75: '[' '' ']'
wrappercheck-79 line 70: exec
wrappercheck-79 line 84: '[' org.gnome.evolution.dataserver.AddressBook ']'
wrappercheck-79 line 85: set +x
*** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.AddressBook'
wrappercheck-79 line 93: kill -0 81
wrappercheck-79 line 94: set +e
wrappercheck-79 line 95: '[' '' ']'
wrappercheck-79 line 99: set -x
wrappercheck-79 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: ./client-test Client::Sync::eds_contact::testItems
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-99 line 16: PIDS=
wrappercheck-99 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-99 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-99 line 21: DAEMON_LOG=
wrappercheck-99 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-99 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-99 line 25: declare -a BACKGROUND
wrappercheck-99 line 26: declare -a ENV
wrappercheck-99 line 28: '[' 10 -gt 1 ']'
wrappercheck-99 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-99 line 29: case "$1" in
wrappercheck-99 line 31: shift
wrappercheck-99 line 32: DAEMON_LOG=evolution-calendar-factory.log
wrappercheck-99 line 53: shift
wrappercheck-99 line 28: '[' 8 -gt 1 ']'
wrappercheck-99 line 28: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-99 line 29: case "$1" in
wrappercheck-99 line 50: break
wrappercheck-99 line 56: '[' 8 -gt 1 ']'
wrappercheck-99 line 56: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-99 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-calendar-factory
wrappercheck-99 line 58: shift
wrappercheck-99 line 56: '[' 7 -gt 1 ']'
wrappercheck-99 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-99 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-99 line 58: shift
wrappercheck-99 line 56: '[' 6 -gt 1 ']'
wrappercheck-99 line 56: '[' -- '!=' -- ']'
wrappercheck-99 line 60: shift
wrappercheck-99 line 62: '[' evolution-calendar-factory.log ']'
wrappercheck-99 line 62: '[' '' ']'
wrappercheck-99 line 66: set +x
*** starting /usr/lib/evolution/evolution-calendar-factory as background daemon, output to evolution-calendar-factory.log
wrappercheck-99 line 72: BACKGROUND_PID=101
wrappercheck-99 line 73: PIDS+=101
wrappercheck-99 line 75: '[' evolution-calendar-factory.log ']'
wrappercheck-99 line 75: '[' '' ']'
wrappercheck-99 line 84: '[' '' ']'
wrappercheck-99 line 93: kill -0 101
wrappercheck-99 line 94: set +e
wrappercheck-99 line 95: '[' '' ']'
wrappercheck-99 line 99: set -x
wrappercheck-99 line 99: env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: ./client-test Client::Sync::eds_contact::testItems
wrappercheck-99 line 70: set -x
wrappercheck-99 line 70: exec
Client::Sync::eds_contact::testItems okay

wrappercheck-99 line 100: RET=0
wrappercheck-99 line 101: set -e
wrappercheck-99 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-calendar-factory
wrappercheck-99 line 108: kill -INT -101
wrappercheck-99 line 108: kill -TERM -101
wrappercheck-99 line 108: kill -TERM 101
wrappercheck-99 line 110: KILL_PID=209
wrappercheck-99 line 115: set +e
wrappercheck-99 line 109: perl -e 'sleep(60); kill(9, -101);'
wrappercheck-99 line 116: wait 101
wrappercheck-99 line 117: SUBRET=143
wrappercheck-99 line 118: case $SUBRET in
wrappercheck-99 line 118: SUBRET=0
wrappercheck-99 line 120: SUBRET=0
wrappercheck-99 line 121: '[' 209 ']'
wwrappercheck-99 line 122: LC_ALL=C
wwrappercheck-99 line 122: kill -KILL 209
wrappercheck-99 line 122: msg=
wrappercheck-99 line 123: echo ''
wrappercheck-99 line 123: grep -q 'No such process'
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   209 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-99 line 127: echo ''

wrappercheck-99 line 129: wait 209
wrappercheck-99 line 131: set -e
wrappercheck-99 line 132: '[' 0 = 0 ']'
wrappercheck-99 line 133: RET=0
wrappercheck-99 line 136: exit 0
wrappercheck-79 line 100: RET=0
wrappercheck-79 line 101: set -e
wrappercheck-79 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-addressbook-factory
wrappercheck-79 line 108: kill -INT -81
wrappercheck-79 line 108: kill -TERM -81
wrappercheck-79 line 108: kill -TERM 81
wrappercheck-79 line 110: KILL_PID=214
wrappercheck-79 line 109: perl -e 'sleep(60); kill(9, -81);'
wrappercheck-79 line 115: set +e
wrappercheck-79 line 116: wait 81
wrappercheck-79 line 117: SUBRET=143
wrappercheck-79 line 118: case $SUBRET in
wrappercheck-79 line 118: SUBRET=0
wrappercheck-79 line 120: SUBRET=0
wrappercheck-79 line 121: '[' 214 ']'
wwrappercheck-79 line 122: LC_ALL=C
wwrappercheck-79 line 122: kill -KILL 214
wrappercheck-79 line 122: msg=
wrappercheck-79 line 123: echo ''
wrappercheck-79 line 123: grep -q 'No such process'
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   214 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-79 line 127: echo ''

wrappercheck-79 line 129: wait 214
wrappercheck-79 line 131: set -e
wrappercheck-79 line 132: '[' 0 = 0 ']'
wrappercheck-79 line 133: RET=0
wrappercheck-79 line 136: exit 0
wrappercheck-20 line 100: RET=0
wrappercheck-20 line 101: set -e
wrappercheck-20 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-source-registry
wrappercheck-20 line 108: kill -INT -26
wrappercheck-20 line 108: kill -TERM -26
wrappercheck-20 line 108: kill -TERM 26
wrappercheck-20 line 110: KILL_PID=219
wrappercheck-20 line 115: set +e
wrappercheck-20 line 109: perl -e 'sleep(60); kill(9, -26);'
wrappercheck-20 line 116: wait 26
wrappercheck-20 line 117: SUBRET=143
wrappercheck-20 line 118: case $SUBRET in
wrappercheck-20 line 118: SUBRET=0
wrappercheck-20 line 120: SUBRET=0
wrappercheck-20 line 121: '[' 219 ']'
wwrappercheck-20 line 122: LC_ALL=C
wwrappercheck-20 line 122: kill -KILL 219
wrappercheck-20 line 122: msg=
wrappercheck-20 line 123: echo ''
wrappercheck-20 line 123: grep -q 'No such process'
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   219 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-20 line 127: echo ''

wrappercheck-20 line 129: wait 219
wrappercheck-20 line 131: set -e
wrappercheck-20 line 132: '[' 0 = 0 ']'
wrappercheck-20 line 133: RET=0
wrappercheck-20 line 136: exit 0
wrappercheck-15 line 100: RET=0
wrappercheck-15 line 101: set -e
wrappercheck-15 line 107: set +x
*** killing and waiting for dbus-monitor
wrappercheck-15 line 108: kill -INT -17
wrappercheck-15 line 108: kill -TERM -17
wrappercheck-15 line 108: kill -TERM 17
wrappercheck-15 line 110: KILL_PID=224
wrappercheck-15 line 109: perl -e 'sleep(60); kill(9, -17);'
wrappercheck-15 line 115: set +e
wrappercheck-15 line 116: wait 17
wrappercheck-15 line 117: SUBRET=143
wrappercheck-15 line 118: case $SUBRET in
wrappercheck-15 line 118: SUBRET=0
wrappercheck-15 line 120: SUBRET=0
wrappercheck-15 line 121: '[' 224 ']'
wwrappercheck-15 line 122: LC_ALL=C
wwrappercheck-15 line 122: kill -KILL 224
wrappercheck-15 line 122: msg=
wrappercheck-15 line 123: grep -q 'No such process'
wrappercheck-15 line 123: echo ''
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130:   224 Killed                  perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-15 line 127: echo ''

wrappercheck-15 line 129: wait 224
wrappercheck-15 line 131: set -e
wrappercheck-15 line 132: '[' 0 = 0 ']'
wrappercheck-15 line 133: RET=0
wrappercheck-15 line 136: exit 0
dbus-session.sh: program returned 0
dbus-session.sh: final result 0
dbus-session.sh 1: killing keyring pid 14
dbus-session.sh 1: killing system bus daemon 4
dbus-session.sh 1: killing session bus daemon 8
dbus-session.sh 1: removing XDG_RUNTIME_DIR=/tmp/tmp.DQo742F4CV
Fri Jan  5 16:13:15 2018 UTC (+ 62.6s / 1381.4s) === cleaning up ===