runtests.py-32149 Fri Jan 5 15:30:55 2018 UTC (+ 1.3s / 65.3s) target /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/.config/akonadi/akonadiserverrc: [%General] Driver=QSQLITE3 [QSQLITE3] Name=/data/runtests/work/prebuilt-testing-i386/home/edsdav/data/akonadi/akonadi.db [Debug] Tracer=null runtests.py-32149 Fri Jan 5 15:30:56 2018 UTC (+ 0.2s / 65.5s) target /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/.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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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/prebuilt-testing-i386/home/edsdav/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-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/.cache new /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/cache old /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/.config new /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/config old /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/.local/share new /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/home/edsdav/data runtests.py-32149 Fri Jan 5 15:30:56 2018 UTC (+ 0.0s / 65.5s) === starting edsdav === runtests.py-32149 Fri Jan 5 15:30:56 2018 UTC (+ 0.0s / 65.5s) result dir: /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/home/nightly/results/2018-01-05-07-10_all/prebuilt-testing-i386/27-edsdav, /proc/self/cwd -> /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/home/nightly/results/2018-01-05-07-10_all/prebuilt-testing-i386/27-edsdav runtests.py-32149 Fri Jan 5 15:30:56 2018 UTC (+ 0.0s / 65.5s) changing into directory /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/tests/edsdav (= /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/tests/edsdav) runtests.py-32149 Fri Jan 5 15:30:56 2018 UTC (+ 0.0s / 65.5s) *** ( cd /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/tests/edsdav; export 'LD_LIBRARY_PATH=/data/runtests/install/testing-i386/libical/lib' '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/prebuilt-testing-i386/home/edsdav' 'XDG_CONFIG_HOME=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config' 'XDG_DATA_HOME=/data/runtests/work/prebuilt-testing-i386/home/edsdav/data' 'XDG_CACHE_HOME=/data/runtests/work/prebuilt-testing-i386/home/edsdav/cache'; unset ; /data/runtests/work/sources/syncevolution/test/resources.py -j 1 -r edsdav -- env CLIENT_TEST_SIMPLE_UID=1 CLIENT_TEST_NUM_ITEMS=10 CLIENT_TEST_LOG=syncevohttp.log CLIENT_TEST_DELETE_REFRESH=1 CLIENT_TEST_PEER_CAN_RESTART=1 CLIENT_TEST_SKIP= schroot -d /data/runtests/work/prebuilt-testing-i386/tests/edsdav -r -p -c 2018-01-05-07-10-all-prebuilt-testing-i386 -- env LD_LIBRARY_PATH=/data/runtests/install/testing-i386/libical/lib 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 /data/runtests/work/sources/syncevolution/test/wrappercheck.sh /usr/libexec/activesyncd -- /home/nightly/testing/setup-syncevolution.sh edsdav ./syncevolution ) Fri Jan 5 15:30:56 2018 UTC (+ 0.0s / 0.0s) === locking resource(s) ['edsdav'] === Fri Jan 5 15:41:50 2018 UTC (+ 654.2s / 654.2s) property changed: status = acquired Fri Jan 5 15:41:50 2018 UTC (+ 0.0s / 654.2s) using jobserver Fri Jan 5 15:41:50 2018 UTC (+ 0.0s / 654.2s) === allocating 1 job slot(s) === Fri Jan 5 15:42:40 2018 UTC (+ 49.9s / 704.1s) === 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-prebuilt-testing-i386 chroot] Running command: “env LD_LIBRARY_PATH=/data/runtests/install/testing-i386/libical/lib 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 /data/runtests/work/sources/syncevolution/test/wrappercheck.sh /usr/libexec/activesyncd -- /home/nightly/testing/setup-syncevolution.sh edsdav ./syncevolution” + 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: '[' 35 -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: '[' 33 -gt 1 ']' wrappercheck-15 line 28: '[' dbus-monitor '!=' -- ']' wrappercheck-15 line 29: case "$1" in wrappercheck-15 line 50: break wrappercheck-15 line 56: '[' 33 -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: '[' 32 -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: '[' 31 -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 wrappercheck-15 line 94: set +e wrappercheck-15 line 95: '[' '' ']' gnome-keyring-daemon: insufficient process capabilities, unsecure memory might get used ** Message: couldn't access control socket: /tmp/tmp.mWBndfYAba/keyring/control: No such file or directory 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 /data/runtests/work/sources/syncevolution/test/wrappercheck.sh /usr/libexec/activesyncd -- /home/nightly/testing/setup-syncevolution.sh edsdav ./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: '[' 29 -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: '[' 27 -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: '[' 25 -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: '[' 23 -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: '[' 23 -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: '[' 22 -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 /data/runtests/work/sources/syncevolution/test/wrappercheck.sh /usr/libexec/activesyncd -- /home/nightly/testing/setup-syncevolution.sh edsdav ./syncevolution + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-72 line 16: PIDS= wrappercheck-72 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-72 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-72 line 21: DAEMON_LOG= wrappercheck-72 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-72 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-72 line 25: declare -a BACKGROUND wrappercheck-72 line 26: declare -a ENV wrappercheck-72 line 28: '[' 20 -gt 1 ']' wrappercheck-72 line 28: '[' --daemon-log '!=' -- ']' wrappercheck-72 line 29: case "$1" in wrappercheck-72 line 31: shift wrappercheck-72 line 32: DAEMON_LOG=evolution-addressbook-factory.log wrappercheck-72 line 53: shift wrappercheck-72 line 28: '[' 18 -gt 1 ']' wrappercheck-72 line 28: '[' --wait-for-dbus-daemon '!=' -- ']' wrappercheck-72 line 29: case "$1" in wrappercheck-72 line 35: shift wrappercheck-72 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.AddressBook wrappercheck-72 line 53: shift wrappercheck-72 line 28: '[' 16 -gt 1 ']' wrappercheck-72 line 28: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']' wrappercheck-72 line 29: case "$1" in wrappercheck-72 line 50: break wrappercheck-72 line 56: '[' 16 -gt 1 ']' wrappercheck-72 line 56: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']' wrappercheck-72 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-addressbook-factory wrappercheck-72 line 58: shift wrappercheck-72 line 56: '[' 15 -gt 1 ']' wrappercheck-72 line 56: '[' --keep-running '!=' -- ']' wrappercheck-72 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running wrappercheck-72 line 58: shift wrappercheck-72 line 56: '[' 14 -gt 1 ']' wrappercheck-72 line 56: '[' -- '!=' -- ']' wrappercheck-72 line 60: shift wrappercheck-72 line 62: '[' evolution-addressbook-factory.log ']' wrappercheck-72 line 62: '[' '' ']' wrappercheck-72 line 66: set +x *** starting /usr/lib/evolution/evolution-addressbook-factory as background daemon, output to evolution-addressbook-factory.log wrappercheck-72 line 72: BACKGROUND_PID=74 wrappercheck-72 line 73: PIDS+=74 wrappercheck-72 line 70: set -x wrappercheck-72 line 75: '[' evolution-addressbook-factory.log ']' wrappercheck-72 line 70: exec wrappercheck-72 line 75: '[' '' ']' wrappercheck-72 line 84: '[' org.gnome.evolution.dataserver.AddressBook ']' wrappercheck-72 line 85: set +x *** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.AddressBook' wrappercheck-72 line 93: kill -0 74 wrappercheck-72 line 94: set +e wrappercheck-72 line 95: '[' '' ']' wrappercheck-72 line 99: set -x wrappercheck-72 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 /data/runtests/work/sources/syncevolution/test/wrappercheck.sh /usr/libexec/activesyncd -- /home/nightly/testing/setup-syncevolution.sh edsdav ./syncevolution + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-92 line 16: PIDS= wrappercheck-92 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-92 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-92 line 21: DAEMON_LOG= wrappercheck-92 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-92 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-92 line 25: declare -a BACKGROUND wrappercheck-92 line 26: declare -a ENV wrappercheck-92 line 28: '[' 12 -gt 1 ']' wrappercheck-92 line 28: '[' --daemon-log '!=' -- ']' wrappercheck-92 line 29: case "$1" in wrappercheck-92 line 31: shift wrappercheck-92 line 32: DAEMON_LOG=evolution-calendar-factory.log wrappercheck-92 line 53: shift wrappercheck-92 line 28: '[' 10 -gt 1 ']' wrappercheck-92 line 28: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']' wrappercheck-92 line 29: case "$1" in wrappercheck-92 line 50: break wrappercheck-92 line 56: '[' 10 -gt 1 ']' wrappercheck-92 line 56: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']' wrappercheck-92 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-calendar-factory wrappercheck-92 line 58: shift wrappercheck-92 line 56: '[' 9 -gt 1 ']' wrappercheck-92 line 56: '[' --keep-running '!=' -- ']' wrappercheck-92 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running wrappercheck-92 line 58: shift wrappercheck-92 line 56: '[' 8 -gt 1 ']' wrappercheck-92 line 56: '[' -- '!=' -- ']' wrappercheck-92 line 60: shift wrappercheck-92 line 62: '[' evolution-calendar-factory.log ']' wrappercheck-92 line 62: '[' '' ']' wrappercheck-92 line 66: set +x *** starting /usr/lib/evolution/evolution-calendar-factory as background daemon, output to evolution-calendar-factory.log wrappercheck-92 line 72: BACKGROUND_PID=94 wrappercheck-92 line 73: PIDS+=94 wrappercheck-92 line 75: '[' evolution-calendar-factory.log ']' wrappercheck-92 line 75: '[' '' ']' wrappercheck-92 line 70: set -x wrappercheck-92 line 84: '[' '' ']' wrappercheck-92 line 70: exec wrappercheck-92 line 93: kill -0 94 wrappercheck-92 line 94: set +e wrappercheck-92 line 95: '[' '' ']' wrappercheck-92 line 99: set -x wrappercheck-92 line 99: env /data/runtests/work/sources/syncevolution/test/wrappercheck.sh /usr/libexec/activesyncd -- /home/nightly/testing/setup-syncevolution.sh edsdav ./syncevolution + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-97 line 16: PIDS= wrappercheck-97 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-97 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-97 line 21: DAEMON_LOG= wrappercheck-97 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-97 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-97 line 25: declare -a BACKGROUND wrappercheck-97 line 26: declare -a ENV wrappercheck-97 line 28: '[' 5 -gt 1 ']' wrappercheck-97 line 28: '[' /usr/libexec/activesyncd '!=' -- ']' wrappercheck-97 line 29: case "$1" in wrappercheck-97 line 50: break wrappercheck-97 line 56: '[' 5 -gt 1 ']' wrappercheck-97 line 56: '[' /usr/libexec/activesyncd '!=' -- ']' wrappercheck-97 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/libexec/activesyncd wrappercheck-97 line 58: shift wrappercheck-97 line 56: '[' 4 -gt 1 ']' wrappercheck-97 line 56: '[' -- '!=' -- ']' wrappercheck-97 line 60: shift wrappercheck-97 line 62: '[' '' ']' wrappercheck-97 line 66: set +x *** starting /usr/libexec/activesyncd as background daemon, output to stderr wrappercheck-97 line 72: BACKGROUND_PID=99 wrappercheck-97 line 73: PIDS+=99 wrappercheck-97 line 75: '[' '' ']' wrappercheck-97 line 84: '[' '' ']' wrappercheck-97 line 93: kill -0 99 wrappercheck-97 line 94: set +e wrappercheck-97 line 95: '[' '' ']' wrappercheck-97 line 70: set -x wrappercheck-97 line 70: exec wrappercheck-97 line 99: set -x wrappercheck-97 line 99: /home/nightly/testing/setup-syncevolution.sh edsdav ./syncevolution + case $TEST in + rm -rf '/data/runtests/work/prebuilt-testing-i386/home/edsdav/.sync4j/evolution/edsdav_[12]' '/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/edsdav_[12]' '/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-[12]/peers/edsdav_[12]' '/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-[12]' + for client in 1 2 + grep -q -e '[+ ]1.[0-9]' + ./syncevolution --version + config=edsdav_1@client-test-edsdav-1 ++ credentials edsdav_1 ++ case "$SCHROOT_CHROOT_NAME" in ++ case $1 in ++ echo '--template SyncEvolution --sync-property username=user01 --sync-property password=user01pw --sync-property deviceID=client-edsdav_1 --sync-property syncURL=http://127.0.0.1:9904/syncevolution --sync-property retryDuration=120s --sync-property useProxy=0' + ./syncevolution --daemon=no --configure --template edsdav --template SyncEvolution --sync-property username=user01 --sync-property password=user01pw --sync-property deviceID=client-edsdav_1 --sync-property syncURL=http://127.0.0.1:9904/syncevolution --sync-property retryDuration=120s --sync-property useProxy=0 --sync-property proxyHost=http://proxy.vlan13.01.org:3128 --sync-property useProxy=0 --sync-property logLevel=4 edsdav_1@client-test-edsdav-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/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources addressbook eds_contact + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources + shift + source=addressbook + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/addressbook ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/addressbook /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/eds_contact + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources calendar eds_event + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources + shift + source=calendar + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/calendar ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/calendar /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/eds_event + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources todo eds_task + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources + shift + source=todo + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/todo ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/todo /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/eds_task + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources memo eds_memo + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources + shift + source=memo + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/memo ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/memo /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-1/peers/edsdav_1/sources/eds_memo + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_contact_1 edsdav_1@client-test-edsdav-1 eds_contact + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_event_1 edsdav_1@client-test-edsdav-1 eds_event + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_task_1 edsdav_1@client-test-edsdav-1 eds_task + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_memo_1 edsdav_1@client-test-edsdav-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=edsdav_2@client-test-edsdav-2 ++ credentials edsdav_2 ++ case "$SCHROOT_CHROOT_NAME" in ++ case $1 in ++ echo '--template SyncEvolution --sync-property username=user01 --sync-property password=user01pw --sync-property deviceID=client-edsdav_2 --sync-property syncURL=http://127.0.0.1:9904/syncevolution --sync-property retryDuration=120s --sync-property useProxy=0' + ./syncevolution --daemon=no --configure --template edsdav --template SyncEvolution --sync-property username=user01 --sync-property password=user01pw --sync-property deviceID=client-edsdav_2 --sync-property syncURL=http://127.0.0.1:9904/syncevolution --sync-property retryDuration=120s --sync-property useProxy=0 --sync-property proxyHost=http://proxy.vlan13.01.org:3128 --sync-property useProxy=0 --sync-property logLevel=4 edsdav_2@client-test-edsdav-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/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources addressbook eds_contact + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources + shift + source=addressbook + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/addressbook ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/addressbook /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/eds_contact + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources calendar eds_event + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources + shift + source=calendar + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/calendar ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/calendar /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/eds_event + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources todo eds_task + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources + shift + source=todo + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/todo ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/todo /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/eds_task + copy_source /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources memo eds_memo + path=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources + shift + source=memo + shift + '[' -d /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/memo ']' + for i in $@ + cp -r /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/memo /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-edsdav-2/peers/edsdav_2/sources/eds_memo + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_contact_2 edsdav_2@client-test-edsdav-2 eds_contact + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_event_2 edsdav_2@client-test-edsdav-2 eds_event + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_task_2 edsdav_2@client-test-edsdav-2 eds_task + for i in eds_contact eds_event eds_task eds_memo + ./syncevolution --daemon=no --configure database=Test_eds_memo_2 edsdav_2@client-test-edsdav-2 eds_memo + case $TEST in + case $TEST in + case $TEST in + case $TEST in + context=client-test-davserver + rm -rf /data/runtests/work/prebuilt-testing-i386/home/edsdav/config/syncevolution/client-test-davserver + ./syncevolution --configure --daemon=no --template SyncEvolution_Client useProxy=0 databaseUser=tester1 databasePassword=testing1 addressbook/backend=CardDAV addressbook/database=http://localhost:9009/davical/caldav.php/tester1/addresses/ calendar/backend=CalDAV calendar/database=http://localhost:9009/davical/caldav.php/tester1/calendar/ todo/backend=CalDAVTodo todo/database=http://localhost:9009/davical/caldav.php/tester1/calendar/ client-edsdav-1@client-test-davserver addressbook calendar todo [INFO] addressbook: configuring datastore with sync mode 'two-way' [INFO] calendar: configuring datastore with sync mode 'two-way' [INFO] todo: configuring datastore with sync mode 'two-way' + for i in 1 2 ++ pwd + ./syncevolution --configure --daemon=no --template SyncEvolution_Client logdir=/data/runtests/work/prebuilt-testing-i386/tests/edsdav/Client_Sync_Current loglevel=4 printChanges=0 dumpData=0 useProxy=0 username=user01 password=user01pw remoteDeviceID=client-edsdav_1 client-edsdav-1@client-test-davserver + for i in 1 2 ++ pwd + ./syncevolution --configure --daemon=no --template SyncEvolution_Client logdir=/data/runtests/work/prebuilt-testing-i386/tests/edsdav/Client_Sync_Current loglevel=4 printChanges=0 dumpData=0 useProxy=0 username=user01 password=user01pw remoteDeviceID=client-edsdav_2 client-edsdav-2@client-test-davserver [INFO] addressbook: configuring datastore with sync mode 'two-way' [INFO] calendar: configuring datastore with sync mode 'two-way' [INFO] memo: checking usability... [INFO] memo: configuring datastore with sync mode 'two-way' [INFO] todo: configuring datastore with sync mode 'two-way' ** (gnome-keyring-daemon:14): WARNING **: asked to register item /org/freedesktop/secrets/collection/default/9, but it's already registered ** (gnome-keyring-daemon:14): WARNING **: asked to register item /org/freedesktop/secrets/collection/default/10, but it's already registered ** (gnome-keyring-daemon:14): WARNING **: asked to register item /org/freedesktop/secrets/collection/default/11, but it's already registered + for i in evolution-contacts=eds_contact evolution-calendar=eds_event evolution-tasks=eds_task evolution-memos=eds_memo ++ sed -e 's/=.*//' ++ echo evolution-contacts=eds_contact + backend=evolution-contacts ++ sed -e 's/.*=//' ++ echo evolution-contacts=eds_contact + 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 + ./syncevolution --daemon=no --print-databases backend=evolution-contacts + grep Test_eds_contact_2 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 ++ echo evolution-calendar=eds_event ++ sed -e 's/.*=//' + name=eds_event + for i in 1 2 + databasename=Test_eds_event_1 + ./syncevolution --daemon=no --print-databases backend=evolution-calendar + grep Test_eds_event_1 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 ++ echo evolution-tasks=eds_task ++ sed -e 's/=.*//' + 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 + grep Test_eds_task_2 + ./syncevolution --daemon=no --print-databases backend=evolution-tasks 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 ++ echo evolution-memos=eds_memo ++ sed -e 's/=.*//' + 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-97 line 100: RET=0 wrappercheck-97 line 101: set -e wrappercheck-97 line 107: set +x *** killing and waiting for /usr/libexec/activesyncd wrappercheck-97 line 108: kill -INT -99 wrappercheck-97 line 108: kill -TERM -99 wrappercheck-97 line 108: kill -TERM 99 wrappercheck-97 line 110: KILL_PID=366 wrappercheck-97 line 115: set +e wrappercheck-97 line 116: wait 99 wrappercheck-97 line 117: SUBRET=143 wrappercheck-97 line 118: case $SUBRET in wrappercheck-97 line 118: SUBRET=0 wrappercheck-97 line 120: SUBRET=0 wrappercheck-97 line 121: '[' 366 ']' wrappercheck-97 line 109: perl -e 'sleep(60); kill(9, -99);' wwrappercheck-97 line 122: LC_ALL=C wwrappercheck-97 line 122: kill -KILL 366 wrappercheck-97 line 122: msg= wrappercheck-97 line 123: echo '' wrappercheck-97 line 123: grep -q 'No such process' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 366 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-97 line 127: echo '' wrappercheck-97 line 129: wait 366 wrappercheck-97 line 131: set -e wrappercheck-97 line 132: '[' 0 = 0 ']' wrappercheck-97 line 133: RET=0 wrappercheck-97 line 136: exit 0 wrappercheck-92 line 100: RET=0 wrappercheck-92 line 101: set -e wrappercheck-92 line 107: set +x *** killing and waiting for /usr/lib/evolution/evolution-calendar-factory wrappercheck-92 line 108: kill -INT -94 wrappercheck-92 line 108: kill -TERM -94 wrappercheck-92 line 108: kill -TERM 94 wrappercheck-92 line 110: KILL_PID=371 wrappercheck-92 line 115: set +e wrappercheck-92 line 109: perl -e 'sleep(60); kill(9, -94);' wrappercheck-92 line 116: wait 94 wrappercheck-92 line 117: SUBRET=143 wrappercheck-92 line 118: case $SUBRET in wrappercheck-92 line 118: SUBRET=0 wrappercheck-92 line 120: SUBRET=0 wrappercheck-92 line 121: '[' 371 ']' wwrappercheck-92 line 122: LC_ALL=C wwrappercheck-92 line 122: kill -KILL 371 wrappercheck-92 line 122: msg= wrappercheck-92 line 123: grep -q 'No such process' wrappercheck-92 line 123: echo '' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 371 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-92 line 127: echo '' wrappercheck-92 line 129: wait 371 wrappercheck-92 line 131: set -e wrappercheck-92 line 132: '[' 0 = 0 ']' wrappercheck-92 line 133: RET=0 wrappercheck-92 line 136: exit 0 wrappercheck-72 line 100: RET=0 wrappercheck-72 line 101: set -e wrappercheck-72 line 107: set +x *** killing and waiting for /usr/lib/evolution/evolution-addressbook-factory wrappercheck-72 line 108: kill -INT -74 wrappercheck-72 line 108: kill -TERM -74 wrappercheck-72 line 108: kill -TERM 74 wrappercheck-72 line 110: KILL_PID=376 wrappercheck-72 line 115: set +e wrappercheck-72 line 116: wait 74 wrappercheck-72 line 109: perl -e 'sleep(60); kill(9, -74);' wrappercheck-72 line 117: SUBRET=143 wrappercheck-72 line 118: case $SUBRET in wrappercheck-72 line 118: SUBRET=0 wrappercheck-72 line 120: SUBRET=0 wrappercheck-72 line 121: '[' 376 ']' wwrappercheck-72 line 122: LC_ALL=C wwrappercheck-72 line 122: kill -KILL 376 wrappercheck-72 line 122: msg= wrappercheck-72 line 123: echo '' wrappercheck-72 line 123: grep -q 'No such process' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 376 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-72 line 127: echo '' wrappercheck-72 line 129: wait 376 wrappercheck-72 line 131: set -e wrappercheck-72 line 132: '[' 0 = 0 ']' wrappercheck-72 line 133: RET=0 wrappercheck-72 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=381 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: '[' 381 ']' wrappercheck-22 line 109: perl -e 'sleep(60); kill(9, -26);' wwrappercheck-22 line 122: LC_ALL=C wwrappercheck-22 line 122: kill -KILL 381 wrappercheck-22 line 122: msg= wrappercheck-22 line 123: echo '' wrappercheck-22 line 123: grep -q 'No such process' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 381 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-22 line 127: echo '' wrappercheck-22 line 129: wait 381 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 -17 wrappercheck-15 line 108: kill -TERM -17 wrappercheck-15 line 108: kill -TERM 17 wrappercheck-15 line 110: KILL_PID=386 wrappercheck-15 line 115: set +e wrappercheck-15 line 109: perl -e 'sleep(60); kill(9, -17);' 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: '[' 386 ']' wwrappercheck-15 line 122: LC_ALL=C wwrappercheck-15 line 122: kill -KILL 386 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: 386 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-15 line 127: echo '' wrappercheck-15 line 129: wait 386 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.mWBndfYAba Fri Jan 5 15:42:50 2018 UTC (+ 10.4s / 714.5s) === cleaning up === runtests.py-32149 Fri Jan 5 15:42:50 2018 UTC (+ 714.5s / 780.0s) *** ( cd /data/schroot/2018-01-05-07-10-all-prebuilt-testing-i386/data/runtests/work/prebuilt-testing-i386/tests/edsdav; export 'LD_LIBRARY_PATH=/data/runtests/install/testing-i386/libical/lib' '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/prebuilt-testing-i386/home/edsdav' 'XDG_CONFIG_HOME=/data/runtests/work/prebuilt-testing-i386/home/edsdav/config' 'XDG_DATA_HOME=/data/runtests/work/prebuilt-testing-i386/home/edsdav/data' 'XDG_CACHE_HOME=/data/runtests/work/prebuilt-testing-i386/home/edsdav/cache'; unset ; /data/runtests/work/sources/syncevolution/test/resources.py -j 1 -r edsdav -- env VALGRIND_LEAK_CHECK_SKIP=akonadi_control,.bin.sh.-c. VALGRIND_LEAK_CHECK_ONLY_FIRST=1 'VALGRIND_ARGS=--show-possibly-lost=no --suppressions=/data/runtests/work/sources/syncevolution/test/sys.supp --suppressions=/data/runtests/work/sources/syncevolution/test/evo.supp --num-callers=30 --trace-children=yes --trace-children-skip=*synclog2html,*synccompare*,*akonadi_*resource,*akonadi_*agent,*akonadi_*feeder,*akonadiserver*,/bin/ls,/bin/sed,/bin/cp,/bin/rm,/usr/bin/kdeinit4,/usr/bin/perl,*/modify-remote,*/modify-local,*/mktemp,*/nslookup,*/host,*/adnshost,*/grep --suppressions=/data/runtests/work/sources/activesyncd/sys.supp' VALGRIND_LOG= http_proxy= CLIENT_TEST_SERVER=edsdav CLIENT_TEST_SOURCES=eds_event,eds_contact SYNC_EVOLUTION_EVO_CALENDAR_DELAY=1 CLIENT_TEST_ALARM=1200 CLIENT_TEST_SIMPLE_UID=1 CLIENT_TEST_NUM_ITEMS=10 CLIENT_TEST_LOG=syncevohttp.log CLIENT_TEST_DELETE_REFRESH=1 CLIENT_TEST_PEER_CAN_RESTART=1 CLIENT_TEST_SKIP= CLIENT_TEST_LOG= CLIENT_TEST_EVOLUTION_PREFIX=Test_ schroot -d /data/runtests/work/prebuilt-testing-i386/tests/edsdav -r -p -c 2018-01-05-07-10-all-prebuilt-testing-i386 -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs:/data/runtests/install/testing-i386/libical/lib 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 PATH=backends/webdav:.:$PATH: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh VALGRIND_CMD_LOG=syncevohttp.log /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh /usr/libexec/syncevo-dbus-server --verbosity=3 --dbus-verbosity=1 --stdout --no-syslog --duration=unlimited -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log syncevohttp.log --wait-for-daemon-output syncevo-http:.listening.on.port.9904 /usr/bin/syncevo-http-server --debug http://127.0.0.1:9904/syncevolution -- /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems ) Fri Jan 5 15:42:50 2018 UTC (+ 0.0s / 0.0s) === locking resource(s) ['edsdav'] === Fri Jan 5 15:56:03 2018 UTC (+ 793.2s / 793.2s) property changed: status = acquired Fri Jan 5 15:56:03 2018 UTC (+ 0.0s / 793.2s) using jobserver Fri Jan 5 15:56:03 2018 UTC (+ 0.0s / 793.2s) === allocating 1 job slot(s) === Fri Jan 5 16:25:30 2018 UTC (+ 1766.5s / 2559.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-prebuilt-testing-i386 chroot] Running command: “env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs:/data/runtests/install/testing-i386/libical/lib 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 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: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh VALGRIND_CMD_LOG=syncevohttp.log /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh /usr/libexec/syncevo-dbus-server --verbosity=3 --dbus-verbosity=1 --stdout --no-syslog --duration=unlimited -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log syncevohttp.log --wait-for-daemon-output syncevo-http:.listening.on.port.9904 /usr/bin/syncevo-http-server --debug http://127.0.0.1:9904/syncevolution -- /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems” gnome-keyring-daemon: insufficient process capabilities, unsecure memory might get used ** Message: couldn't access control socket: /tmp/tmp.kkagMeMI41/keyring/control: No such file or directory + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-19 line 16: PIDS= wrappercheck-19 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-19 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-19 line 21: DAEMON_LOG= wrappercheck-19 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-19 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-19 line 25: declare -a BACKGROUND wrappercheck-19 line 26: declare -a ENV wrappercheck-19 line 28: '[' 53 -gt 1 ']' wrappercheck-19 line 28: '[' --daemon-log '!=' -- ']' wrappercheck-19 line 29: case "$1" in wrappercheck-19 line 31: shift wrappercheck-19 line 32: DAEMON_LOG=dbus-monitor.log wrappercheck-19 line 53: shift wrappercheck-19 line 28: '[' 51 -gt 1 ']' wrappercheck-19 line 28: '[' dbus-monitor '!=' -- ']' wrappercheck-19 line 29: case "$1" in wrappercheck-19 line 50: break wrappercheck-19 line 56: '[' 51 -gt 1 ']' wrappercheck-19 line 56: '[' dbus-monitor '!=' -- ']' wrappercheck-19 line 57: BACKGROUND[${#BACKGROUND[*]}]=dbus-monitor wrappercheck-19 line 58: shift wrappercheck-19 line 56: '[' 50 -gt 1 ']' wrappercheck-19 line 56: '[' interface=org.freedesktop.DBus '!=' -- ']' wrappercheck-19 line 57: BACKGROUND[${#BACKGROUND[*]}]=interface=org.freedesktop.DBus wrappercheck-19 line 58: shift wrappercheck-19 line 56: '[' 49 -gt 1 ']' wrappercheck-19 line 56: '[' -- '!=' -- ']' wrappercheck-19 line 60: shift wrappercheck-19 line 62: '[' dbus-monitor.log ']' wrappercheck-19 line 62: '[' '' ']' wrappercheck-19 line 66: set +x *** starting dbus-monitor as background daemon, output to dbus-monitor.log wrappercheck-19 line 72: BACKGROUND_PID=22 wrappercheck-19 line 73: PIDS+=22 wrappercheck-19 line 70: set -x wrappercheck-19 line 70: exec wrappercheck-19 line 75: '[' dbus-monitor.log ']' wrappercheck-19 line 75: '[' '' ']' wrappercheck-19 line 84: '[' '' ']' wrappercheck-19 line 93: kill -0 22 wrappercheck-19 line 94: set +e wrappercheck-19 line 95: '[' '' ']' wrappercheck-19 line 99: set -x wrappercheck-19 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 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: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh VALGRIND_CMD_LOG=syncevohttp.log /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh /usr/libexec/syncevo-dbus-server --verbosity=3 --dbus-verbosity=1 --stdout --no-syslog --duration=unlimited -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log syncevohttp.log --wait-for-daemon-output syncevo-http:.listening.on.port.9904 /usr/bin/syncevo-http-server --debug http://127.0.0.1:9904/syncevolution -- /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-25 line 16: PIDS= wrappercheck-25 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-25 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-25 line 21: DAEMON_LOG= wrappercheck-25 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-25 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-25 line 25: declare -a BACKGROUND wrappercheck-25 line 26: declare -a ENV wrappercheck-25 line 28: '[' 47 -gt 1 ']' wrappercheck-25 line 28: '[' --daemon-log '!=' -- ']' wrappercheck-25 line 29: case "$1" in wrappercheck-25 line 31: shift wrappercheck-25 line 32: DAEMON_LOG=evolution-source-registry.log wrappercheck-25 line 53: shift wrappercheck-25 line 28: '[' 45 -gt 1 ']' wrappercheck-25 line 28: '[' --daemon-sleep '!=' -- ']' wrappercheck-25 line 29: case "$1" in wrappercheck-25 line 43: shift wrappercheck-25 line 44: DAEMON_SLEEP=5 wrappercheck-25 line 53: shift wrappercheck-25 line 28: '[' 43 -gt 1 ']' wrappercheck-25 line 28: '[' --wait-for-dbus-daemon '!=' -- ']' wrappercheck-25 line 29: case "$1" in wrappercheck-25 line 35: shift wrappercheck-25 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.Sources wrappercheck-25 line 53: shift wrappercheck-25 line 28: '[' 41 -gt 1 ']' wrappercheck-25 line 28: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']' wrappercheck-25 line 29: case "$1" in wrappercheck-25 line 50: break wrappercheck-25 line 56: '[' 41 -gt 1 ']' wrappercheck-25 line 56: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']' wrappercheck-25 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-source-registry wrappercheck-25 line 58: shift wrappercheck-25 line 56: '[' 40 -gt 1 ']' wrappercheck-25 line 56: '[' -- '!=' -- ']' wrappercheck-25 line 60: shift wrappercheck-25 line 62: '[' evolution-source-registry.log ']' wrappercheck-25 line 62: '[' '' ']' wrappercheck-25 line 66: set +x *** starting /usr/lib/evolution/evolution-source-registry as background daemon, output to evolution-source-registry.log wrappercheck-25 line 72: BACKGROUND_PID=29 wrappercheck-25 line 73: PIDS+=29 wrappercheck-25 line 75: '[' evolution-source-registry.log ']' wrappercheck-25 line 75: '[' '' ']' wrappercheck-25 line 84: '[' org.gnome.evolution.dataserver.Sources ']' wrappercheck-25 line 70: set -x wrappercheck-25 line 70: exec wrappercheck-25 line 85: set +x *** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.Sources' ** (gnome-keyring-daemon:14): WARNING **: asked to register item /org/freedesktop/secrets/collection/default/7, but it's already registered wrappercheck-25 line 93: kill -0 29 wrappercheck-25 line 94: set +e wrappercheck-25 line 95: '[' 5 ']' wrappercheck-25 line 96: set +x *** 'sleep 5' for daemon to settle down wrappercheck-25 line 97: sleep 5 wrappercheck-25 line 99: set -x wrappercheck-25 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 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: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh VALGRIND_CMD_LOG=syncevohttp.log /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh /usr/libexec/syncevo-dbus-server --verbosity=3 --dbus-verbosity=1 --stdout --no-syslog --duration=unlimited -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log syncevohttp.log --wait-for-daemon-output syncevo-http:.listening.on.port.9904 /usr/bin/syncevo-http-server --debug http://127.0.0.1:9904/syncevolution -- /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-75 line 16: PIDS= wrappercheck-75 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-75 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-75 line 21: DAEMON_LOG= wrappercheck-75 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-75 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-75 line 25: declare -a BACKGROUND wrappercheck-75 line 26: declare -a ENV wrappercheck-75 line 28: '[' 38 -gt 1 ']' wrappercheck-75 line 28: '[' --daemon-log '!=' -- ']' wrappercheck-75 line 29: case "$1" in wrappercheck-75 line 31: shift wrappercheck-75 line 32: DAEMON_LOG=evolution-addressbook-factory.log wrappercheck-75 line 53: shift wrappercheck-75 line 28: '[' 36 -gt 1 ']' wrappercheck-75 line 28: '[' --wait-for-dbus-daemon '!=' -- ']' wrappercheck-75 line 29: case "$1" in wrappercheck-75 line 35: shift wrappercheck-75 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.AddressBook wrappercheck-75 line 53: shift wrappercheck-75 line 28: '[' 34 -gt 1 ']' wrappercheck-75 line 28: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']' wrappercheck-75 line 29: case "$1" in wrappercheck-75 line 50: break wrappercheck-75 line 56: '[' 34 -gt 1 ']' wrappercheck-75 line 56: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']' wrappercheck-75 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-addressbook-factory wrappercheck-75 line 58: shift wrappercheck-75 line 56: '[' 33 -gt 1 ']' wrappercheck-75 line 56: '[' --keep-running '!=' -- ']' wrappercheck-75 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running wrappercheck-75 line 58: shift wrappercheck-75 line 56: '[' 32 -gt 1 ']' wrappercheck-75 line 56: '[' -- '!=' -- ']' wrappercheck-75 line 60: shift wrappercheck-75 line 62: '[' evolution-addressbook-factory.log ']' wrappercheck-75 line 62: '[' '' ']' wrappercheck-75 line 66: set +x *** starting /usr/lib/evolution/evolution-addressbook-factory as background daemon, output to evolution-addressbook-factory.log wrappercheck-75 line 72: BACKGROUND_PID=77 wrappercheck-75 line 73: PIDS+=77 wrappercheck-75 line 70: set -x wrappercheck-75 line 75: '[' evolution-addressbook-factory.log ']' wrappercheck-75 line 70: exec wrappercheck-75 line 75: '[' '' ']' wrappercheck-75 line 84: '[' org.gnome.evolution.dataserver.AddressBook ']' wrappercheck-75 line 85: set +x *** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.AddressBook' wrappercheck-75 line 93: kill -0 77 wrappercheck-75 line 94: set +e wrappercheck-75 line 95: '[' '' ']' wrappercheck-75 line 99: set -x wrappercheck-75 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 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: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh VALGRIND_CMD_LOG=syncevohttp.log /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh /usr/libexec/syncevo-dbus-server --verbosity=3 --dbus-verbosity=1 --stdout --no-syslog --duration=unlimited -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log syncevohttp.log --wait-for-daemon-output syncevo-http:.listening.on.port.9904 /usr/bin/syncevo-http-server --debug http://127.0.0.1:9904/syncevolution -- /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-95 line 16: PIDS= wrappercheck-95 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-95 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-95 line 21: DAEMON_LOG= wrappercheck-95 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-95 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-95 line 25: declare -a BACKGROUND wrappercheck-95 line 26: declare -a ENV wrappercheck-95 line 28: '[' 30 -gt 1 ']' wrappercheck-95 line 28: '[' --daemon-log '!=' -- ']' wrappercheck-95 line 29: case "$1" in wrappercheck-95 line 31: shift wrappercheck-95 line 32: DAEMON_LOG=evolution-calendar-factory.log wrappercheck-95 line 53: shift wrappercheck-95 line 28: '[' 28 -gt 1 ']' wrappercheck-95 line 28: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']' wrappercheck-95 line 29: case "$1" in wrappercheck-95 line 50: break wrappercheck-95 line 56: '[' 28 -gt 1 ']' wrappercheck-95 line 56: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']' wrappercheck-95 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-calendar-factory wrappercheck-95 line 58: shift wrappercheck-95 line 56: '[' 27 -gt 1 ']' wrappercheck-95 line 56: '[' --keep-running '!=' -- ']' wrappercheck-95 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running wrappercheck-95 line 58: shift wrappercheck-95 line 56: '[' 26 -gt 1 ']' wrappercheck-95 line 56: '[' -- '!=' -- ']' wrappercheck-95 line 60: shift wrappercheck-95 line 62: '[' evolution-calendar-factory.log ']' wrappercheck-95 line 62: '[' '' ']' wrappercheck-95 line 66: set +x *** starting /usr/lib/evolution/evolution-calendar-factory as background daemon, output to evolution-calendar-factory.log wrappercheck-95 line 72: BACKGROUND_PID=97 wrappercheck-95 line 73: PIDS+=97 wrappercheck-95 line 70: set -x wrappercheck-95 line 70: exec wrappercheck-95 line 75: '[' evolution-calendar-factory.log ']' wrappercheck-95 line 75: '[' '' ']' wrappercheck-95 line 84: '[' '' ']' wrappercheck-95 line 93: kill -0 97 wrappercheck-95 line 94: set +e wrappercheck-95 line 95: '[' '' ']' wrappercheck-95 line 99: set -x wrappercheck-95 line 99: env 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: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh VALGRIND_CMD_LOG=syncevohttp.log /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh /usr/libexec/syncevo-dbus-server --verbosity=3 --dbus-verbosity=1 --stdout --no-syslog --duration=unlimited -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log syncevohttp.log --wait-for-daemon-output syncevo-http:.listening.on.port.9904 /usr/bin/syncevo-http-server --debug http://127.0.0.1:9904/syncevolution -- /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-100 line 16: PIDS= wrappercheck-100 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-100 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-100 line 21: DAEMON_LOG= wrappercheck-100 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-100 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-100 line 25: declare -a BACKGROUND wrappercheck-100 line 26: declare -a ENV wrappercheck-100 line 28: '[' 22 -gt 1 ']' wrappercheck-100 line 28: '[' VALGRIND_CMD_LOG=syncevohttp.log '!=' -- ']' wrappercheck-100 line 29: case "$1" in wrappercheck-100 line 47: ENV[${#ENV[*]}]=VALGRIND_CMD_LOG=syncevohttp.log wrappercheck-100 line 53: shift wrappercheck-100 line 28: '[' 21 -gt 1 ']' wrappercheck-100 line 28: '[' /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh '!=' -- ']' wrappercheck-100 line 29: case "$1" in wrappercheck-100 line 50: break wrappercheck-100 line 56: '[' 21 -gt 1 ']' wrappercheck-100 line 56: '[' /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh '!=' -- ']' wrappercheck-100 line 57: BACKGROUND[${#BACKGROUND[*]}]=/data/runtests/work/sources/syncevolution/test/valgrindcheck.sh wrappercheck-100 line 58: shift wrappercheck-100 line 56: '[' 20 -gt 1 ']' wrappercheck-100 line 56: '[' /usr/libexec/syncevo-dbus-server '!=' -- ']' wrappercheck-100 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/libexec/syncevo-dbus-server wrappercheck-100 line 58: shift wrappercheck-100 line 56: '[' 19 -gt 1 ']' wrappercheck-100 line 56: '[' --verbosity=3 '!=' -- ']' wrappercheck-100 line 57: BACKGROUND[${#BACKGROUND[*]}]=--verbosity=3 wrappercheck-100 line 58: shift wrappercheck-100 line 56: '[' 18 -gt 1 ']' wrappercheck-100 line 56: '[' --dbus-verbosity=1 '!=' -- ']' wrappercheck-100 line 57: BACKGROUND[${#BACKGROUND[*]}]=--dbus-verbosity=1 wrappercheck-100 line 58: shift wrappercheck-100 line 56: '[' 17 -gt 1 ']' wrappercheck-100 line 56: '[' --stdout '!=' -- ']' wrappercheck-100 line 57: BACKGROUND[${#BACKGROUND[*]}]=--stdout wrappercheck-100 line 58: shift wrappercheck-100 line 56: '[' 16 -gt 1 ']' wrappercheck-100 line 56: '[' --no-syslog '!=' -- ']' wrappercheck-100 line 57: BACKGROUND[${#BACKGROUND[*]}]=--no-syslog wrappercheck-100 line 58: shift wrappercheck-100 line 56: '[' 15 -gt 1 ']' wrappercheck-100 line 56: '[' --duration=unlimited '!=' -- ']' wrappercheck-100 line 57: BACKGROUND[${#BACKGROUND[*]}]=--duration=unlimited wrappercheck-100 line 58: shift wrappercheck-100 line 56: '[' 14 -gt 1 ']' wrappercheck-100 line 56: '[' -- '!=' -- ']' wrappercheck-100 line 60: shift wrappercheck-100 line 62: '[' '' ']' wrappercheck-100 line 66: set +x *** starting /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh as background daemon, output to stderr wrappercheck-100 line 72: BACKGROUND_PID=104 wrappercheck-100 line 73: PIDS+=104 wrappercheck-100 line 70: set -x wrappercheck-100 line 70: exec wrappercheck-100 line 75: '[' '' ']' wrappercheck-100 line 84: '[' '' ']' wrappercheck-100 line 93: kill -0 104 wrappercheck-100 line 94: set +e wrappercheck-100 line 95: '[' '' ']' wrappercheck-100 line 99: set -x wrappercheck-100 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log syncevohttp.log --wait-for-daemon-output syncevo-http:.listening.on.port.9904 /usr/bin/syncevo-http-server --debug http://127.0.0.1:9904/syncevolution -- /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems + PS4='wrappercheck-$$ line ${LINENO}: ' wrappercheck-107 line 16: PIDS= wrappercheck-107 line 18: trap '[ "" ] && kill -TERM ' TERM wrappercheck-107 line 19: trap '[ "" ] && kill -INT ' INT wrappercheck-107 line 21: DAEMON_LOG= wrappercheck-107 line 22: WAIT_FOR_DAEMON_OUTPUT= wrappercheck-107 line 23: WAIT_FOR_DBUS_DAEMON= wrappercheck-107 line 25: declare -a BACKGROUND wrappercheck-107 line 26: declare -a ENV wrappercheck-107 line 28: '[' 12 -gt 1 ']' wrappercheck-107 line 28: '[' --daemon-log '!=' -- ']' wrappercheck-107 line 29: case "$1" in wrappercheck-107 line 31: shift wrappercheck-107 line 32: DAEMON_LOG=syncevohttp.log wrappercheck-107 line 53: shift wrappercheck-107 line 28: '[' 10 -gt 1 ']' wrappercheck-107 line 28: '[' --wait-for-daemon-output '!=' -- ']' wrappercheck-107 line 29: case "$1" in wrappercheck-107 line 39: shift wrappercheck-107 line 40: WAIT_FOR_DAEMON_OUTPUT=syncevo-http:.listening.on.port.9904 wrappercheck-107 line 53: shift wrappercheck-107 line 28: '[' 8 -gt 1 ']' wrappercheck-107 line 28: '[' /usr/bin/syncevo-http-server '!=' -- ']' wrappercheck-107 line 29: case "$1" in wrappercheck-107 line 50: break wrappercheck-107 line 56: '[' 8 -gt 1 ']' wrappercheck-107 line 56: '[' /usr/bin/syncevo-http-server '!=' -- ']' wrappercheck-107 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/bin/syncevo-http-server wrappercheck-107 line 58: shift wrappercheck-107 line 56: '[' 7 -gt 1 ']' wrappercheck-107 line 56: '[' --debug '!=' -- ']' wrappercheck-107 line 57: BACKGROUND[${#BACKGROUND[*]}]=--debug wrappercheck-107 line 58: shift wrappercheck-107 line 56: '[' 6 -gt 1 ']' wrappercheck-107 line 56: '[' http://127.0.0.1:9904/syncevolution '!=' -- ']' wrappercheck-107 line 57: BACKGROUND[${#BACKGROUND[*]}]=http://127.0.0.1:9904/syncevolution wrappercheck-107 line 58: shift wrappercheck-107 line 56: '[' 5 -gt 1 ']' wrappercheck-107 line 56: '[' -- '!=' -- ']' wrappercheck-107 line 60: shift wrappercheck-107 line 62: '[' syncevohttp.log ']' wrappercheck-107 line 62: '[' syncevo-http:.listening.on.port.9904 ']' wwrappercheck-107 line 63: grep -e syncevo-http:.listening.on.port.9904 syncevohttp.log wwrappercheck-107 line 63: wc -l grep: syncevohttp.log: No such file or directory wrappercheck-107 line 63: daemonmatches=0 wrappercheck-107 line 66: set +x *** starting /usr/bin/syncevo-http-server as background daemon, output to syncevohttp.log wrappercheck-107 line 72: BACKGROUND_PID=112 wrappercheck-107 line 73: PIDS+=112 wrappercheck-107 line 70: set -x wrappercheck-107 line 75: '[' syncevohttp.log ']' wrappercheck-107 line 70: exec wrappercheck-107 line 75: '[' syncevo-http:.listening.on.port.9904 ']' wrappercheck-107 line 76: set +x *** waiting for daemon to write 'syncevo-http:.listening.on.port.9904' into syncevohttp.log wrappercheck-107 line 84: '[' '' ']' wrappercheck-107 line 93: kill -0 112 wrappercheck-107 line 94: set +e wrappercheck-107 line 95: '[' '' ']' wrappercheck-107 line 99: set -x wrappercheck-107 line 99: /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems *** starting ./client-test under valgrind, output to stdout + [ ] + exec env GLIBCXX_FORCE_NEW=1 G_SLICE=always-malloc G_DEBUG=gc-friendly valgrind --show-possibly-lost=no --suppressions=/data/runtests/work/sources/syncevolution/test/sys.supp --suppressions=/data/runtests/work/sources/syncevolution/test/evo.supp --num-callers=30 --trace-children=yes --trace-children-skip=*synclog2html,*synccompare*,*akonadi_*resource,*akonadi_*agent,*akonadi_*feeder,*akonadiserver*,/bin/ls,/bin/sed,/bin/cp,/bin/rm,/usr/bin/kdeinit4,/usr/bin/perl,*/modify-remote,*/modify-local,*/mktemp,*/nslookup,*/host,*/adnshost,*/grep --suppressions=/data/runtests/work/sources/activesyncd/sys.supp --gen-suppressions=all --log-file=/data/runtests/work/prebuilt-testing-i386/tests/edsdav/valgrind.p137.c%p.out ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems Client::Sync::eds_event::testItems okay Client::Sync::eds_contact::testItems okay OKvalgrindcheck (137): './client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems' (141): returned 0 ==141== Memcheck, a memory error detector ==141== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al. ==141== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info ==141== Command: ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems ==141== Parent PID: 137 ==141== ==141== ==141== HEAP SUMMARY: ==141== in use at exit: 289,686 bytes in 4,101 blocks ==141== total heap usage: 106,678 allocs, 102,577 frees, 12,376,712 bytes allocated ==141== ==141== LEAK SUMMARY: ==141== definitely lost: 0 bytes in 0 blocks ==141== indirectly lost: 0 bytes in 0 blocks ==141== possibly lost: 52 bytes in 1 blocks ==141== still reachable: 127,249 bytes in 678 blocks ==141== of which reachable via heuristic: ==141== newarray : 4,712 bytes in 17 blocks ==141== suppressed: 162,385 bytes in 3,422 blocks ==141== Rerun with --leak-check=full to see details of leaked memory ==141== ==141== For counts of detected and suppressed errors, rerun with: -v ==141== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0) ==144== Memcheck, a memory error detector ==144== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al. ==144== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info ==144== Command: ./client-test Client::Sync::eds_event::testItems ==144== Parent PID: 141 ==144== ==144== ==144== HEAP SUMMARY: ==144== in use at exit: 5,746,970 bytes in 58,162 blocks ==144== total heap usage: 2,187,311 allocs, 2,129,096 frees, 219,485,214 bytes allocated ==144== ==144== LEAK SUMMARY: ==144== definitely lost: 0 bytes in 0 blocks ==144== indirectly lost: 0 bytes in 0 blocks ==144== possibly lost: 484 bytes in 3 blocks ==144== still reachable: 5,259,722 bytes in 48,427 blocks ==144== of which reachable via heuristic: ==144== newarray : 8,028 bytes in 154 blocks ==144== suppressed: 435,844 bytes in 9,061 blocks ==144== Rerun with --leak-check=full to see details of leaked memory ==144== ==144== For counts of detected and suppressed errors, rerun with: -v ==144== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0) ==201== Memcheck, a memory error detector ==201== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al. ==201== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info ==201== Command: ./client-test Client::Sync::eds_event::testItems ==201== Parent PID: 144 ==201== ==244== Memcheck, a memory error detector ==244== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al. ==244== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info ==244== Command: ./client-test Client::Sync::eds_event::testItems ==244== Parent PID: 144 ==244== ==249== Memcheck, a memory error detector ==249== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al. ==249== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info ==249== Command: ./client-test Client::Sync::eds_contact::testItems ==249== Parent PID: 141 ==249== ==249== ==249== HEAP SUMMARY: ==249== in use at exit: 5,777,736 bytes in 58,451 blocks ==249== total heap usage: 2,162,564 allocs, 2,104,060 frees, 220,435,394 bytes allocated ==249== ==249== LEAK SUMMARY: ==249== definitely lost: 0 bytes in 0 blocks ==249== indirectly lost: 0 bytes in 0 blocks ==249== possibly lost: 484 bytes in 3 blocks ==249== still reachable: 5,302,361 bytes in 48,387 blocks ==249== of which reachable via heuristic: ==249== newarray : 8,008 bytes in 153 blocks ==249== suppressed: 412,427 bytes in 9,265 blocks ==249== Rerun with --leak-check=full to see details of leaked memory ==249== ==249== For counts of detected and suppressed errors, rerun with: -v ==249== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0) ==305== Memcheck, a memory error detector ==305== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al. ==305== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info ==305== Command: ./client-test Client::Sync::eds_contact::testItems ==305== Parent PID: 249 ==305== ==350== Memcheck, a memory error detector ==350== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al. ==350== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info ==350== Command: ./client-test Client::Sync::eds_contact::testItems ==350== Parent PID: 249 ==350== valgrindcheck: ./client-test Client::Sync::eds_event::testItems Client::Sync::eds_contact::testItems: final result 0 wrappercheck-107 line 100: RET=0 wrappercheck-107 line 101: set -e wrappercheck-107 line 107: set +x *** killing and waiting for /usr/bin/syncevo-http-server wrappercheck-107 line 108: kill -INT -112 wrappercheck-107 line 108: kill -TERM -112 wrappercheck-107 line 108: kill -TERM 112 wrappercheck-107 line 110: KILL_PID=454 wrappercheck-107 line 115: set +e wrappercheck-107 line 109: perl -e 'sleep(60); kill(9, -112);' wrappercheck-107 line 116: wait 112 wrappercheck-107 line 117: SUBRET=143 wrappercheck-107 line 118: case $SUBRET in wrappercheck-107 line 118: SUBRET=0 wrappercheck-107 line 120: SUBRET=0 wrappercheck-107 line 121: '[' 454 ']' wwrappercheck-107 line 122: LC_ALL=C wwrappercheck-107 line 122: kill -KILL 454 wrappercheck-107 line 122: msg= wrappercheck-107 line 123: grep -q 'No such process' wrappercheck-107 line 123: echo '' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 454 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-107 line 127: echo '' wrappercheck-107 line 129: wait 454 wrappercheck-107 line 131: set -e wrappercheck-107 line 132: '[' 0 = 0 ']' wrappercheck-107 line 133: RET=0 wrappercheck-107 line 136: exit 0 wrappercheck-100 line 100: RET=0 wrappercheck-100 line 101: set -e wrappercheck-100 line 107: set +x *** killing and waiting for /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh wrappercheck-100 line 108: kill -INT -104 wrappercheck-100 line 108: kill -TERM -104 wrappercheck-100 line 108: kill -TERM 104 wrappercheck-100 line 110: KILL_PID=459 wrappercheck-100 line 115: set +e wrappercheck-100 line 116: wait 104 wrappercheck-100 line 109: perl -e 'sleep(60); kill(9, -104);' wrappercheck-100 line 117: SUBRET=143 wrappercheck-100 line 118: case $SUBRET in wrappercheck-100 line 118: SUBRET=0 wrappercheck-100 line 120: SUBRET=0 wrappercheck-100 line 121: '[' 459 ']' wwrappercheck-100 line 122: LC_ALL=C wwrappercheck-100 line 122: kill -KILL 459 wrappercheck-100 line 122: msg= wrappercheck-100 line 123: grep -q 'No such process' wrappercheck-100 line 123: echo '' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 459 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-100 line 127: echo '' wrappercheck-100 line 129: wait 459 wrappercheck-100 line 131: set -e wrappercheck-100 line 132: '[' 0 = 0 ']' wrappercheck-100 line 133: RET=0 wrappercheck-100 line 136: exit 0 wrappercheck-95 line 100: RET=0 wrappercheck-95 line 101: set -e wrappercheck-95 line 107: set +x *** killing and waiting for /usr/lib/evolution/evolution-calendar-factory wrappercheck-95 line 108: kill -INT -97 wrappercheck-95 line 108: kill -TERM -97 wrappercheck-95 line 108: kill -TERM 97 wrappercheck-95 line 110: KILL_PID=465 wrappercheck-95 line 115: set +e wrappercheck-95 line 116: wait 97 wrappercheck-95 line 117: SUBRET=143 wrappercheck-95 line 118: case $SUBRET in wrappercheck-95 line 118: SUBRET=0 wrappercheck-95 line 120: SUBRET=0 wrappercheck-95 line 121: '[' 465 ']' wwrappercheck-95 line 122: LC_ALL=C wwrappercheck-95 line 122: kill -KILL 465 wrappercheck-95 line 122: msg= wrappercheck-95 line 123: echo '' wrappercheck-95 line 123: grep -q 'No such process' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 465 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-95 line 127: echo '' wrappercheck-95 line 129: wait 465 wrappercheck-95 line 131: set -e wrappercheck-95 line 132: '[' 0 = 0 ']' wrappercheck-95 line 133: RET=0 wrappercheck-95 line 136: exit 0 wrappercheck-75 line 100: RET=0 wrappercheck-75 line 101: set -e wrappercheck-75 line 107: set +x *** killing and waiting for /usr/lib/evolution/evolution-addressbook-factory wrappercheck-75 line 108: kill -INT -77 wrappercheck-75 line 108: kill -TERM -77 wrappercheck-75 line 108: kill -TERM 77 wrappercheck-75 line 110: KILL_PID=470 wrappercheck-75 line 115: set +e wrappercheck-75 line 116: wait 77 wrappercheck-75 line 117: SUBRET=143 wrappercheck-75 line 118: case $SUBRET in wrappercheck-75 line 118: SUBRET=0 wrappercheck-75 line 120: SUBRET=0 wrappercheck-75 line 121: '[' 470 ']' wrappercheck-75 line 109: perl -e 'sleep(60); kill(9, -77);' wwrappercheck-75 line 122: LC_ALL=C wwrappercheck-75 line 122: kill -KILL 470 wrappercheck-75 line 122: msg= wrappercheck-75 line 123: echo '' wrappercheck-75 line 123: grep -q 'No such process' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 470 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-75 line 127: echo '' wrappercheck-75 line 129: wait 470 wrappercheck-75 line 131: set -e wrappercheck-75 line 132: '[' 0 = 0 ']' wrappercheck-75 line 133: RET=0 wrappercheck-75 line 136: exit 0 wrappercheck-25 line 100: RET=0 wrappercheck-25 line 101: set -e wrappercheck-25 line 107: set +x *** killing and waiting for /usr/lib/evolution/evolution-source-registry wrappercheck-25 line 108: kill -INT -29 wrappercheck-25 line 108: kill -TERM -29 wrappercheck-25 line 108: kill -TERM 29 wrappercheck-25 line 110: KILL_PID=475 wrappercheck-25 line 115: set +e wrappercheck-25 line 116: wait 29 wrappercheck-25 line 109: perl -e 'sleep(60); kill(9, -29);' wrappercheck-25 line 117: SUBRET=143 wrappercheck-25 line 118: case $SUBRET in wrappercheck-25 line 118: SUBRET=0 wrappercheck-25 line 120: SUBRET=0 wrappercheck-25 line 121: '[' 475 ']' wwrappercheck-25 line 122: LC_ALL=C wwrappercheck-25 line 122: kill -KILL 475 wrappercheck-25 line 122: msg= wrappercheck-25 line 123: echo '' wrappercheck-25 line 123: grep -q 'No such process' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 475 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-25 line 127: echo '' wrappercheck-25 line 129: wait 475 wrappercheck-25 line 131: set -e wrappercheck-25 line 132: '[' 0 = 0 ']' wrappercheck-25 line 133: RET=0 wrappercheck-25 line 136: exit 0 wrappercheck-19 line 100: RET=0 wrappercheck-19 line 101: set -e wrappercheck-19 line 107: set +x *** killing and waiting for dbus-monitor wrappercheck-19 line 108: kill -INT -22 wrappercheck-19 line 108: kill -TERM -22 wrappercheck-19 line 108: kill -TERM 22 wrappercheck-19 line 110: KILL_PID=480 wrappercheck-19 line 115: set +e wrappercheck-19 line 116: wait 22 wrappercheck-19 line 109: perl -e 'sleep(60); kill(9, -22);' wrappercheck-19 line 117: SUBRET=143 wrappercheck-19 line 118: case $SUBRET in wrappercheck-19 line 118: SUBRET=0 wrappercheck-19 line 120: SUBRET=0 wrappercheck-19 line 121: '[' 480 ']' wwrappercheck-19 line 122: LC_ALL=C wwrappercheck-19 line 122: kill -KILL 480 wrappercheck-19 line 122: msg= wrappercheck-19 line 123: echo '' wrappercheck-19 line 123: grep -q 'No such process' /data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 480 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);" wrappercheck-19 line 127: echo '' wrappercheck-19 line 129: wait 480 wrappercheck-19 line 131: set -e wrappercheck-19 line 132: '[' 0 = 0 ']' wrappercheck-19 line 133: RET=0 wrappercheck-19 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.kkagMeMI41 Fri Jan 5 16:30:20 2018 UTC (+ 290.1s / 2849.8s) === cleaning up ===