runtests.py-2280 Fri Jan 5 15:31:04 2018 UTC (+ 0.8s / 109.2s) target /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/.config/akonadi/akonadiserverrc:
[%General]
Driver=QSQLITE3
[QSQLITE3]
Name=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/data/akonadi/akonadi.db
[Debug]
Tracer=null
runtests.py-2280 Fri Jan 5 15:31:04 2018 UTC (+ 0.1s / 109.3s) target /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/.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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/home/googlecontacts/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-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/.cache new /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/cache
old /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/.config new /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config
old /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/.local/share new /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/data
runtests.py-2280 Fri Jan 5 15:31:04 2018 UTC (+ 0.0s / 109.3s) === starting googlecontacts ===
runtests.py-2280 Fri Jan 5 15:31:04 2018 UTC (+ 0.1s / 109.4s) result dir: /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/home/nightly/results/2018-01-05-07-10_all/prebuilt-testing-amd64/14-googlecontacts, /proc/self/cwd -> /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/home/nightly/results/2018-01-05-07-10_all/prebuilt-testing-amd64/14-googlecontacts
runtests.py-2280 Fri Jan 5 15:31:04 2018 UTC (+ 0.2s / 109.6s) changing into directory /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/tests/googlecontacts (= /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/tests/googlecontacts)
runtests.py-2280 Fri Jan 5 15:31:04 2018 UTC (+ 0.0s / 109.6s) *** ( cd /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/tests/googlecontacts; export 'PATH=/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin' 'HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts' 'XDG_CONFIG_HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config' 'XDG_DATA_HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/data' 'XDG_CACHE_HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/cache'; unset LD_LIBRARY_PATH; /data/runtests/work/sources/syncevolution/test/resources.py -j 1 -r googlecontacts -- env 'CLIENT_TEST_WEBDAV=google carddav' CLIENT_TEST_NUM_ITEMS=10 CLIENT_TEST_MODE=server CLIENT_TEST_FAILURES= schroot -d /data/runtests/work/prebuilt-testing-amd64/tests/googlecontacts -r -p -c 2018-01-05-07-10-all-prebuilt-testing-amd64 -- env 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 googlecontacts ./syncevolution )
Fri Jan 5 15:31:04 2018 UTC (+ 0.0s / 0.0s) === locking resource(s) ['googlecontacts'] ===
Fri Jan 5 15:31:04 2018 UTC (+ 0.1s / 0.1s) property changed: status = acquired
Fri Jan 5 15:31:04 2018 UTC (+ 0.1s / 0.2s) using jobserver
Fri Jan 5 15:31:04 2018 UTC (+ 0.0s / 0.2s) === allocating 1 job slot(s) ===
Fri Jan 5 15:31:17 2018 UTC (+ 12.6s / 12.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-cppcheck] 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-amd64 chroot] Running command: “env 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 googlecontacts ./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 75: '[' dbus-monitor.log ']'
wrappercheck-15 line 75: '[' '' ']'
wrappercheck-15 line 84: '[' '' ']'
wrappercheck-15 line 93: kill -0 17
gnome-keyring-daemon: insufficient process capabilities, unsecure memory might get used
wrappercheck-15 line 94: set +e
wrappercheck-15 line 95: '[' '' ']'
wrappercheck-15 line 70: set -x
wrappercheck-15 line 99: set -x
wrappercheck-15 line 70: exec
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 googlecontacts ./syncevolution
** Message: couldn't access control socket: /tmp/tmp.lNJnMECdiB/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: '[' 29 -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=evolution-source-registry.log
wrappercheck-19 line 53: shift
wrappercheck-19 line 28: '[' 27 -gt 1 ']'
wrappercheck-19 line 28: '[' --daemon-sleep '!=' -- ']'
wrappercheck-19 line 29: case "$1" in
wrappercheck-19 line 43: shift
wrappercheck-19 line 44: DAEMON_SLEEP=5
wrappercheck-19 line 53: shift
wrappercheck-19 line 28: '[' 25 -gt 1 ']'
wrappercheck-19 line 28: '[' --wait-for-dbus-daemon '!=' -- ']'
wrappercheck-19 line 29: case "$1" in
wrappercheck-19 line 35: shift
wrappercheck-19 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.Sources
wrappercheck-19 line 53: shift
wrappercheck-19 line 28: '[' 23 -gt 1 ']'
wrappercheck-19 line 28: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']'
wrappercheck-19 line 29: case "$1" in
wrappercheck-19 line 50: break
wrappercheck-19 line 56: '[' 23 -gt 1 ']'
wrappercheck-19 line 56: '[' /usr/lib/evolution/evolution-source-registry '!=' -- ']'
wrappercheck-19 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-source-registry
wrappercheck-19 line 58: shift
wrappercheck-19 line 56: '[' 22 -gt 1 ']'
wrappercheck-19 line 56: '[' -- '!=' -- ']'
wrappercheck-19 line 60: shift
wrappercheck-19 line 62: '[' evolution-source-registry.log ']'
wrappercheck-19 line 62: '[' '' ']'
wrappercheck-19 line 66: set +x
*** starting /usr/lib/evolution/evolution-source-registry as background daemon, output to evolution-source-registry.log
wrappercheck-19 line 72: BACKGROUND_PID=24
wrappercheck-19 line 73: PIDS+=24
wrappercheck-19 line 70: set -x
wrappercheck-19 line 75: '[' evolution-source-registry.log ']'
wrappercheck-19 line 70: exec
wrappercheck-19 line 75: '[' '' ']'
wrappercheck-19 line 84: '[' org.gnome.evolution.dataserver.Sources ']'
wrappercheck-19 line 85: set +x
*** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.Sources'
wrappercheck-19 line 93: kill -0 24
wrappercheck-19 line 94: set +e
wrappercheck-19 line 95: '[' 5 ']'
wrappercheck-19 line 96: set +x
*** 'sleep 5' for daemon to settle down
wrappercheck-19 line 97: sleep 5
wrappercheck-19 line 99: set -x
wrappercheck-19 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 googlecontacts ./syncevolution
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-82 line 16: PIDS=
wrappercheck-82 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-82 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-82 line 21: DAEMON_LOG=
wrappercheck-82 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-82 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-82 line 25: declare -a BACKGROUND
wrappercheck-82 line 26: declare -a ENV
wrappercheck-82 line 28: '[' 20 -gt 1 ']'
wrappercheck-82 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-82 line 29: case "$1" in
wrappercheck-82 line 31: shift
wrappercheck-82 line 32: DAEMON_LOG=evolution-addressbook-factory.log
wrappercheck-82 line 53: shift
wrappercheck-82 line 28: '[' 18 -gt 1 ']'
wrappercheck-82 line 28: '[' --wait-for-dbus-daemon '!=' -- ']'
wrappercheck-82 line 29: case "$1" in
wrappercheck-82 line 35: shift
wrappercheck-82 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.AddressBook
wrappercheck-82 line 53: shift
wrappercheck-82 line 28: '[' 16 -gt 1 ']'
wrappercheck-82 line 28: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-82 line 29: case "$1" in
wrappercheck-82 line 50: break
wrappercheck-82 line 56: '[' 16 -gt 1 ']'
wrappercheck-82 line 56: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-82 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-addressbook-factory
wrappercheck-82 line 58: shift
wrappercheck-82 line 56: '[' 15 -gt 1 ']'
wrappercheck-82 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-82 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-82 line 58: shift
wrappercheck-82 line 56: '[' 14 -gt 1 ']'
wrappercheck-82 line 56: '[' -- '!=' -- ']'
wrappercheck-82 line 60: shift
wrappercheck-82 line 62: '[' evolution-addressbook-factory.log ']'
wrappercheck-82 line 62: '[' '' ']'
wrappercheck-82 line 66: set +x
*** starting /usr/lib/evolution/evolution-addressbook-factory as background daemon, output to evolution-addressbook-factory.log
wrappercheck-82 line 72: BACKGROUND_PID=84
wrappercheck-82 line 73: PIDS+=84
wrappercheck-82 line 75: '[' evolution-addressbook-factory.log ']'
wrappercheck-82 line 75: '[' '' ']'
wrappercheck-82 line 84: '[' org.gnome.evolution.dataserver.AddressBook ']'
wrappercheck-82 line 70: set -x
wrappercheck-82 line 70: exec
wrappercheck-82 line 85: set +x
*** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.AddressBook'
wrappercheck-82 line 93: kill -0 84
wrappercheck-82 line 94: set +e
wrappercheck-82 line 95: '[' '' ']'
wrappercheck-82 line 99: set -x
wrappercheck-82 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 googlecontacts ./syncevolution
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-102 line 16: PIDS=
wrappercheck-102 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-102 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-102 line 21: DAEMON_LOG=
wrappercheck-102 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-102 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-102 line 25: declare -a BACKGROUND
wrappercheck-102 line 26: declare -a ENV
wrappercheck-102 line 28: '[' 12 -gt 1 ']'
wrappercheck-102 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-102 line 29: case "$1" in
wrappercheck-102 line 31: shift
wrappercheck-102 line 32: DAEMON_LOG=evolution-calendar-factory.log
wrappercheck-102 line 53: shift
wrappercheck-102 line 28: '[' 10 -gt 1 ']'
wrappercheck-102 line 28: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-102 line 29: case "$1" in
wrappercheck-102 line 50: break
wrappercheck-102 line 56: '[' 10 -gt 1 ']'
wrappercheck-102 line 56: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-102 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-calendar-factory
wrappercheck-102 line 58: shift
wrappercheck-102 line 56: '[' 9 -gt 1 ']'
wrappercheck-102 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-102 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-102 line 58: shift
wrappercheck-102 line 56: '[' 8 -gt 1 ']'
wrappercheck-102 line 56: '[' -- '!=' -- ']'
wrappercheck-102 line 60: shift
wrappercheck-102 line 62: '[' evolution-calendar-factory.log ']'
wrappercheck-102 line 62: '[' '' ']'
wrappercheck-102 line 66: set +x
*** starting /usr/lib/evolution/evolution-calendar-factory as background daemon, output to evolution-calendar-factory.log
wrappercheck-102 line 72: BACKGROUND_PID=104
wrappercheck-102 line 73: PIDS+=104
wrappercheck-102 line 75: '[' evolution-calendar-factory.log ']'
wrappercheck-102 line 75: '[' '' ']'
wrappercheck-102 line 84: '[' '' ']'
wrappercheck-102 line 93: kill -0 104
wrappercheck-102 line 94: set +e
wrappercheck-102 line 95: '[' '' ']'
wrappercheck-102 line 99: set -x
wrappercheck-102 line 99: env /data/runtests/work/sources/syncevolution/test/wrappercheck.sh /usr/libexec/activesyncd -- /home/nightly/testing/setup-syncevolution.sh googlecontacts ./syncevolution
wrappercheck-102 line 70: set -x
wrappercheck-102 line 70: exec
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-106 line 16: PIDS=
wrappercheck-106 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-106 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-106 line 21: DAEMON_LOG=
wrappercheck-106 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-106 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-106 line 25: declare -a BACKGROUND
wrappercheck-106 line 26: declare -a ENV
wrappercheck-106 line 28: '[' 5 -gt 1 ']'
wrappercheck-106 line 28: '[' /usr/libexec/activesyncd '!=' -- ']'
wrappercheck-106 line 29: case "$1" in
wrappercheck-106 line 50: break
wrappercheck-106 line 56: '[' 5 -gt 1 ']'
wrappercheck-106 line 56: '[' /usr/libexec/activesyncd '!=' -- ']'
wrappercheck-106 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/libexec/activesyncd
wrappercheck-106 line 58: shift
wrappercheck-106 line 56: '[' 4 -gt 1 ']'
wrappercheck-106 line 56: '[' -- '!=' -- ']'
wrappercheck-106 line 60: shift
wrappercheck-106 line 62: '[' '' ']'
wrappercheck-106 line 66: set +x
*** starting /usr/libexec/activesyncd as background daemon, output to stderr
wrappercheck-106 line 72: BACKGROUND_PID=109
wrappercheck-106 line 73: PIDS+=109
wrappercheck-106 line 75: '[' '' ']'
wrappercheck-106 line 84: '[' '' ']'
wrappercheck-106 line 93: kill -0 109
wrappercheck-106 line 94: set +e
wrappercheck-106 line 95: '[' '' ']'
wrappercheck-106 line 70: set -x
wrappercheck-106 line 70: exec
wrappercheck-106 line 99: set -x
wrappercheck-106 line 99: /home/nightly/testing/setup-syncevolution.sh googlecontacts ./syncevolution
+ case $TEST in
+ rm -rf '/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/.sync4j/evolution/googlecontacts_[12]' '/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/googlecontacts_[12]' '/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-[12]/peers/googlecontacts_[12]' '/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-[12]'
+ for client in 1 2
+ ./syncevolution --version
+ grep -q -e '[+ ]1.[0-9]'
+ config=googlecontacts_1@client-test-googlecontacts-1
++ credentials googlecontacts_1
++ case "$SCHROOT_CHROOT_NAME" in
++ case $1 in
++ echo '--template SyncEvolution_Client username= password= syncURL=local://@client-test-googlecontacts addressbook/uri=carddav'
+ ./syncevolution --daemon=no --configure --template googlecontacts --template SyncEvolution_Client username= password= syncURL=local://@client-test-googlecontacts addressbook/uri=carddav --sync-property proxyHost=http://proxy.vlan13.01.org:3128 --sync-property useProxy=0 --sync-property logLevel=4 googlecontacts_1@client-test-googlecontacts-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-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources addressbook eds_contact
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources
+ shift
+ source=addressbook
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/addressbook ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/addressbook /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/eds_contact
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources calendar eds_event
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources
+ shift
+ source=calendar
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/calendar ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/calendar /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/eds_event
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources todo eds_task
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources
+ shift
+ source=todo
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/todo ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/todo /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/eds_task
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources memo eds_memo
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources
+ shift
+ source=memo
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/memo ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/memo /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-1/peers/googlecontacts_1/sources/eds_memo
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_contact_1 googlecontacts_1@client-test-googlecontacts-1 eds_contact
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_event_1 googlecontacts_1@client-test-googlecontacts-1 eds_event
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_task_1 googlecontacts_1@client-test-googlecontacts-1 eds_task
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_memo_1 googlecontacts_1@client-test-googlecontacts-1 eds_memo
+ case $TEST in
+ case $TEST in
+ case $TEST in
++ SYNCEVOLUTION_DEBUG=1
++ ./syncevolution --print-databases --daemon=no loglevel=4 syncURL=https://www.googleapis.com/.well-known/carddav username=goa:syncevolution.list@gmail.com backend=carddav
[DEBUG 00:00:00] using username 'goa:syncevolution.list@gmail.com' from context for WebDAV, password not set
[DEBUG 00:00:00] looking for identity provider for goa:syncevolution.list@gmail.com
[DEBUG 00:00:00] Looking up all accounts in GNOME Online Accounts, searching for 'syncevolution.list@gmail.com'.
[DEBUG 00:00:00] GOA object /org/gnome/OnlineAccounts/Accounts/account_1379073187 implements org.gnome.OnlineAccounts.Account, org.gnome.OnlineAccounts.Calendar, org.gnome.OnlineAccounts.Chat, org.gnome.OnlineAccounts.Contacts, org.gnome.OnlineAccounts.Documents, org.gnome.OnlineAccounts.Mail, org.gnome.OnlineAccounts.OAuth2Based
[DEBUG 00:00:00] GOA account Google, syncevolution.list@gmail.com = account_1379073187
[DEBUG 00:00:00] found matching GNOME Online Account for 'syncevolution.list@gmail.com': Google, syncevolution.list@gmail.com = account_1379073187
[DEBUG 00:00:00] GOA object /org/gnome/OnlineAccounts/Manager implements org.gnome.OnlineAccounts.Manager
[DEBUG 00:00:00] timout 300s, retry 5s => resending allowed
HTTP session to https://www.googleapis.com:443 begins.
[DEBUG 00:00:00] client cert is missing
[INFO 00:00:00] start database search at https://www.googleapis.com/.well-known/carddav, from sync config '@default', syncURL='https://www.googleapis.com/.well-known/carddav'
[DEBUG 00:00:00] testing https://www.googleapis.com:443/.well-known/carddav
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/.well-known/carddav
[DEBUG 00:00:00] starting PROPFIND, credentials unverified, no deadline
[DEBUG 00:00:00] got new OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' for next request
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /.well-known/carddav HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Doing DNS lookup on proxy.vlan13.01.org...
req: Connecting to 10.0.13.1:3128
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
CONNECT www.googleapis.com:443 HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Request sent; retry is 0.
[status-line] < HTTP/1.1 200 Connection established
[hdr]
End of headers.
Running post_headers hooks
Running post_send hooks
Request ends, status 200 class 2xx, error line:
200 Connection established
Running destroy hooks.
Request ends.
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 0.
[status-line] < HTTP/1.1 301 Moved Permanently
[hdr] Cache-Control: no-cache, no-store, max-age=0, must-revalidate
Header Name: [cache-control], Value: [no-cache, no-store, max-age=0, must-revalidate]
[hdr] Pragma: no-cache
Header Name: [pragma], Value: [no-cache]
[hdr] Expires: Mon, 01 Jan 1990 00:00:00 GMT
Header Name: [expires], Value: [Mon, 01 Jan 1990 00:00:00 GMT]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Location: /carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
Header Name: [location], Value: [/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/html; charset=UTF-8
Header Name: [content-type], Value: [text/html; charset=UTF-8]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < f8
Got chunk size: 248
Reading 248 bytes of response body.
Got 248 bytes.
Read block (248 bytes):
[
Moved Permanently
Moved Permanently
The document has moved here.
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 301 (want 401), WWW-Authenticate is (none)
Request ends, status 301 class 3xx, error line:
301 Moved Permanently
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] TransportException thrown at /data/runtests/work/sources/syncevolution/src/backends/webdav/NeonCXX.cpp:602
[DEBUG 00:00:00] transport problem: PROPFIND: 301 status: /.well-known/carddav redirected to /carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/.well-known/carddav
[DEBUG 00:00:00] starting PROPFIND, credentials unverified, deadline in 299.8s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /.well-known/carddav HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 301 Moved Permanently
[hdr] Cache-Control: no-cache, no-store, max-age=0, must-revalidate
Header Name: [cache-control], Value: [no-cache, no-store, max-age=0, must-revalidate]
[hdr] Pragma: no-cache
Header Name: [pragma], Value: [no-cache]
[hdr] Expires: Mon, 01 Jan 1990 00:00:00 GMT
Header Name: [expires], Value: [Mon, 01 Jan 1990 00:00:00 GMT]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Location: /carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
Header Name: [location], Value: [/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/html; charset=UTF-8
Header Name: [content-type], Value: [text/html; charset=UTF-8]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < f8
Got chunk size: 248
Reading 248 bytes of response body.
Got 248 bytes.
Read block (248 bytes):
[
Moved Permanently
Moved Permanently
The document has moved here.
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 301 (want 401), WWW-Authenticate is (none)
Request ends, status 301 class 3xx, error line:
301 Moved Permanently
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] new candidate from https://www.googleapis.com:443/.well-known/carddav -> https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ redirect
[DEBUG 00:00:00] follow candidate https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials unverified, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1b7
Got chunk size: 439
Reading 439 bytes of response body.
Got 439 bytes.
Read block (439 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.7s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 672
Got chunk size: 1650
Reading 1650 bytes of response body.
Got 605 bytes.
Read block (605 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
Address Book
My Contacts
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] current-user-privilege-set:
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00] found Address Book = https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] follow current-user-prinicipal to https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] skipping listing because collection cannot contain other relevant collections: https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] starting PROPFIND, credentials okay, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1a9
Got chunk size: 425
Reading 425 bytes of response body.
Got 425 bytes.
Read block (425 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.6s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 6a4
Got chunk size: 1700
Reading 1700 bytes of response body.
Got 605 bytes.
Read block (605 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/
HTTP/1.1 200 OK
Principal
]
Reading 1095 bytes of response body.
Got 1095 bytes.
Read block (1095 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] use properties for '/carddav/v1/principals/syncevolution.list%40gmail.com/' instead of 'https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com'
[DEBUG 00:00:00] follow home-set property to https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] skipping listing because we don't know whether collection contains relevant collections: https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1af
Got chunk size: 431
Reading 431 bytes of response body.
Got 431 bytes.
Read block (431 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.5s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 623
Got chunk size: 1571
Reading 1571 bytes of response body.
Got 648 bytes.
Read block (648 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
HTTP/1.1 200 OK
Homeset
]
Reading 923 bytes of response body.
Got 923 bytes.
Read block (923 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] list items in https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.5s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 1
Content-Length: 339
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (339 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 510
Got chunk size: 1296
Reading 1296 bytes of response body.
Got 648 bytes.
Read block (648 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
HTTP/1.1 200 OK
Homeset
HTTP/1.1 404 Not Found
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
Address Book
My Contacts
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] skipping because already checked: /carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] new sub candidate: /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] follow candidate https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1b7
Got chunk size: 439
Reading 439 bytes of response body.
Got 439 bytes.
Read block (439 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.4s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:35 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:35 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 672
Got chunk size: 1650
Reading 1650 bytes of response body.
Got 605 bytes.
Read block (605 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
Address Book
My Contacts
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] current-user-privilege-set:
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00] found Address Book = https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] skipping listing because collection cannot contain other relevant collections: https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
sess: Destroying session.
+ databases='carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
+ echo 'carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/)
++ pick_default 'carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
++ perl -e 'while (<>) { if (/^.*?\((.*)\) $/) { print "$1"; exit 0 } }; exit 1;'
++ echo 'carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
++ '[' 0 -ne 0 ']'
+ database=https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
+ ./syncevolution --configure --daemon=no database=https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ databaseUser=goa:syncevolution.list@gmail.com backend=carddav googlecontacts_1@client-test-googlecontacts-1 google_carddav
+ for client in 1 2
+ grep -q -e '[+ ]1.[0-9]'
+ ./syncevolution --version
+ config=googlecontacts_2@client-test-googlecontacts-2
++ credentials googlecontacts_2
++ case "$SCHROOT_CHROOT_NAME" in
++ case $1 in
++ echo '--template SyncEvolution_Client username= password= syncURL=local://@client-test-googlecontacts addressbook/uri=carddav'
+ ./syncevolution --daemon=no --configure --template googlecontacts --template SyncEvolution_Client username= password= syncURL=local://@client-test-googlecontacts addressbook/uri=carddav --sync-property proxyHost=http://proxy.vlan13.01.org:3128 --sync-property useProxy=0 --sync-property logLevel=4 googlecontacts_2@client-test-googlecontacts-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'
+ sources=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources addressbook eds_contact
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources
+ shift
+ source=addressbook
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/addressbook ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/addressbook /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/eds_contact
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources calendar eds_event
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources
+ shift
+ source=calendar
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/calendar ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/calendar /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/eds_event
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources todo eds_task
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources
+ shift
+ source=todo
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/todo ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/todo /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/eds_task
+ copy_source /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources memo eds_memo
+ path=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources
+ shift
+ source=memo
+ shift
+ '[' -d /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/memo ']'
+ for i in $@
+ cp -r /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/memo /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts-2/peers/googlecontacts_2/sources/eds_memo
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_contact_2 googlecontacts_2@client-test-googlecontacts-2 eds_contact
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_event_2 googlecontacts_2@client-test-googlecontacts-2 eds_event
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_task_2 googlecontacts_2@client-test-googlecontacts-2 eds_task
+ for i in eds_contact eds_event eds_task eds_memo
+ ./syncevolution --daemon=no --configure database=Test_eds_memo_2 googlecontacts_2@client-test-googlecontacts-2 eds_memo
+ case $TEST in
+ case $TEST in
+ case $TEST in
++ SYNCEVOLUTION_DEBUG=1
++ ./syncevolution --print-databases --daemon=no loglevel=4 syncURL=https://www.googleapis.com/.well-known/carddav username=goa:syncevolution.list@gmail.com backend=carddav
[DEBUG 00:00:00] using username 'goa:syncevolution.list@gmail.com' from context for WebDAV, password not set
[DEBUG 00:00:00] looking for identity provider for goa:syncevolution.list@gmail.com
[DEBUG 00:00:00] Looking up all accounts in GNOME Online Accounts, searching for 'syncevolution.list@gmail.com'.
[DEBUG 00:00:00] GOA object /org/gnome/OnlineAccounts/Accounts/account_1379073187 implements org.gnome.OnlineAccounts.Account, org.gnome.OnlineAccounts.Calendar, org.gnome.OnlineAccounts.Chat, org.gnome.OnlineAccounts.Contacts, org.gnome.OnlineAccounts.Documents, org.gnome.OnlineAccounts.Mail, org.gnome.OnlineAccounts.OAuth2Based
[DEBUG 00:00:00] GOA account Google, syncevolution.list@gmail.com = account_1379073187
[DEBUG 00:00:00] found matching GNOME Online Account for 'syncevolution.list@gmail.com': Google, syncevolution.list@gmail.com = account_1379073187
[DEBUG 00:00:00] GOA object /org/gnome/OnlineAccounts/Manager implements org.gnome.OnlineAccounts.Manager
[DEBUG 00:00:00] timout 300s, retry 5s => resending allowed
HTTP session to https://www.googleapis.com:443 begins.
[DEBUG 00:00:00] client cert is missing
[INFO 00:00:00] start database search at https://www.googleapis.com/.well-known/carddav, from sync config '@default', syncURL='https://www.googleapis.com/.well-known/carddav'
[DEBUG 00:00:00] testing https://www.googleapis.com:443/.well-known/carddav
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/.well-known/carddav
[DEBUG 00:00:00] starting PROPFIND, credentials unverified, no deadline
[DEBUG 00:00:00] got new OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' for next request
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /.well-known/carddav HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Doing DNS lookup on proxy.vlan13.01.org...
req: Connecting to 10.0.13.1:3128
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
CONNECT www.googleapis.com:443 HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Request sent; retry is 0.
[status-line] < HTTP/1.1 200 Connection established
[hdr]
End of headers.
Running post_headers hooks
Running post_send hooks
Request ends, status 200 class 2xx, error line:
200 Connection established
Running destroy hooks.
Request ends.
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 0.
[status-line] < HTTP/1.1 301 Moved Permanently
[hdr] Cache-Control: no-cache, no-store, max-age=0, must-revalidate
Header Name: [cache-control], Value: [no-cache, no-store, max-age=0, must-revalidate]
[hdr] Pragma: no-cache
Header Name: [pragma], Value: [no-cache]
[hdr] Expires: Mon, 01 Jan 1990 00:00:00 GMT
Header Name: [expires], Value: [Mon, 01 Jan 1990 00:00:00 GMT]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Location: /carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
Header Name: [location], Value: [/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/html; charset=UTF-8
Header Name: [content-type], Value: [text/html; charset=UTF-8]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < f8
Got chunk size: 248
Reading 248 bytes of response body.
Got 248 bytes.
Read block (248 bytes):
[
Moved Permanently
Moved Permanently
The document has moved here.
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 301 (want 401), WWW-Authenticate is (none)
Request ends, status 301 class 3xx, error line:
301 Moved Permanently
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] TransportException thrown at /data/runtests/work/sources/syncevolution/src/backends/webdav/NeonCXX.cpp:602
[DEBUG 00:00:00] transport problem: PROPFIND: 301 status: /.well-known/carddav redirected to /carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/.well-known/carddav
[DEBUG 00:00:00] starting PROPFIND, credentials unverified, deadline in 299.7s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /.well-known/carddav HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 301 Moved Permanently
[hdr] Cache-Control: no-cache, no-store, max-age=0, must-revalidate
Header Name: [cache-control], Value: [no-cache, no-store, max-age=0, must-revalidate]
[hdr] Pragma: no-cache
Header Name: [pragma], Value: [no-cache]
[hdr] Expires: Mon, 01 Jan 1990 00:00:00 GMT
Header Name: [expires], Value: [Mon, 01 Jan 1990 00:00:00 GMT]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Location: /carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
Header Name: [location], Value: [/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/html; charset=UTF-8
Header Name: [content-type], Value: [text/html; charset=UTF-8]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < f8
Got chunk size: 248
Reading 248 bytes of response body.
Got 248 bytes.
Read block (248 bytes):
[
Moved Permanently
Moved Permanently
The document has moved here.
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 301 (want 401), WWW-Authenticate is (none)
Request ends, status 301 class 3xx, error line:
301 Moved Permanently
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] new candidate from https://www.googleapis.com:443/.well-known/carddav -> https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ redirect
[DEBUG 00:00:00] follow candidate https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials unverified, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1b7
Got chunk size: 439
Reading 439 bytes of response body.
Got 439 bytes.
Read block (439 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.6s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 672
Got chunk size: 1650
Reading 1650 bytes of response body.
Got 605 bytes.
Read block (605 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
Address Book
My Contacts
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] current-user-privilege-set:
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00] found Address Book = https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] follow current-user-prinicipal to https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] skipping listing because collection cannot contain other relevant collections: https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] starting PROPFIND, credentials okay, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1a9
Got chunk size: 425
Reading 425 bytes of response body.
Got 425 bytes.
Read block (425 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.6s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 6a4
Got chunk size: 1700
Reading 1700 bytes of response body.
Got 605 bytes.
Read block (605 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/
HTTP/1.1 200 OK
Principal
]
Reading 1095 bytes of response body.
Got 1095 bytes.
Read block (1095 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] use properties for '/carddav/v1/principals/syncevolution.list%40gmail.com/' instead of 'https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com'
[DEBUG 00:00:00] follow home-set property to https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] skipping listing because we don't know whether collection contains relevant collections: https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1af
Got chunk size: 431
Reading 431 bytes of response body.
Got 431 bytes.
Read block (431 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.5s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 623
Got chunk size: 1571
Reading 1571 bytes of response body.
Got 648 bytes.
Read block (648 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
HTTP/1.1 200 OK
Homeset
]
Reading 923 bytes of response body.
Got 923 bytes.
Read block (923 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] list items in https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.4s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 1
Content-Length: 339
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (339 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 510
Got chunk size: 1296
Reading 1296 bytes of response body.
Got 648 bytes.
Read block (648 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/
HTTP/1.1 200 OK
Homeset
HTTP/1.1 404 Not Found
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
Address Book
My Contacts
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] skipping because already checked: /carddav/v1/principals/syncevolution.list%40gmail.com/lists/
[DEBUG 00:00:00] new sub candidate: /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] follow candidate https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] testing https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] debugging: read all WebDAV properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, no deadline
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 84
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (84 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 1b7
Got chunk size: 439
Reading 439 bytes of response body.
Got 439 bytes.
Read block (439 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] read relevant properties of https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] starting PROPFIND, credentials okay, deadline in 299.4s
ah_create, for WWW-Authenticate
Running pre_send hooks
[DEBUG 00:00:00] using OAuth2 token 'ya29.Glw5BUQp9msUYpjK1tdSt88HCwQHtRlYbKXG27Chgh8J9PtXZqoAWukE-D9ySBMA3ukYej20btTTdRASCF1JeoHDuoFxu0q8FwCtoofOUuU6BdtGLuY0j06IPrgrBw' to authenticate
Sending request headers:
PROPFIND /carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ HTTP/1.1
Connection: TE
TE: trailers
Host: www.googleapis.com
Depth: 0
Content-Length: 671
Content-Type: application/xml
User-Agent: SyncEvolution
Authorization: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx
Sending request-line and headers:
Sending request body:
Body block (671 bytes):
[
]
Request sent; retry is 1.
[status-line] < HTTP/1.1 207 Multi-Status
[hdr] DAV: 1, 2, 3, addressbook, access-control
Header Name: [dav], Value: [1, 2, 3, addressbook, access-control]
[hdr] Vary: X-Origin
Header Name: [vary], Value: [X-Origin]
[hdr] Content-Type: text/xml; charset=UTF-8
Header Name: [content-type], Value: [text/xml; charset=UTF-8]
[hdr] Date: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [date], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Expires: Fri, 05 Jan 2018 15:31:37 GMT
Header Name: [expires], Value: [Fri, 05 Jan 2018 15:31:37 GMT]
[hdr] Cache-Control: private, max-age=0
Header Name: [cache-control], Value: [private, max-age=0]
[hdr] X-Content-Type-Options: nosniff
Header Name: [x-content-type-options], Value: [nosniff]
[hdr] X-Frame-Options: SAMEORIGIN
Header Name: [x-frame-options], Value: [SAMEORIGIN]
[hdr] X-XSS-Protection: 1; mode=block
Header Name: [x-xss-protection], Value: [1; mode=block]
[hdr] Server: GSE
Header Name: [server], Value: [GSE]
[hdr] Alt-Svc: hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"
Header Name: [alt-svc], Value: [hq=":443"; ma=2592000; quic=51303431; quic=51303339; quic=51303338; quic=51303337; quic=51303335,quic=":443"; ma=2592000; v="41,39,38,37,35"]
[hdr] Accept-Ranges: none
Header Name: [accept-ranges], Value: [none]
[hdr] Vary: Origin,Accept-Encoding
Header Name: [vary], Value: [Origin,Accept-Encoding]
[hdr] Transfer-Encoding: chunked
Header Name: [transfer-encoding], Value: [chunked]
[hdr]
End of headers.
Running post_headers hooks
[chunk] < 672
Got chunk size: 1650
Reading 1650 bytes of response body.
Got 605 bytes.
Read block (605 bytes):
[
/carddav/v1/principals/syncevolution.list@gmail.com/lists/default/
HTTP/1.1 200 OK
Address Book
My Contacts
/carddav/v1/principals/syncevolution.list@gmail.com/
/carddav/v1/principals/syncevolution.list@gmail.com
HTTP/1.1 404 Not Found
]
[chunk] < 0
Got chunk size: 0
[hdr]
End of headers.
Running post_send hooks
ah_post_send (#0), code is 207 (want 401), WWW-Authenticate is (none)
Request ends, status 207 class 2xx, error line:
207 Multi-Status
[DEBUG 00:00:00] credentials accepted
Running destroy hooks.
Request ends.
[DEBUG 00:00:00] current-user-privilege-set:
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00]
[DEBUG 00:00:00] found Address Book = https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
[DEBUG 00:00:00] skipping listing because collection cannot contain other relevant collections: https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
sess: Destroying session.
+ databases='carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
+ echo 'carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/)
++ pick_default 'carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
++ perl -e 'while (<>) { if (/^.*?\((.*)\) $/) { print "$1"; exit 0 } }; exit 1;'
++ echo 'carddav:
Address Book (https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/) '
++ '[' 0 -ne 0 ']'
+ database=https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/
+ ./syncevolution --configure --daemon=no database=https://www.googleapis.com:443/carddav/v1/principals/syncevolution.list%40gmail.com/lists/default/ databaseUser=goa:syncevolution.list@gmail.com backend=carddav googlecontacts_2@client-test-googlecontacts-2 google_carddav
+ case $TEST in
+ rm -rf /data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config/syncevolution/client-test-googlecontacts
+ ./syncevolution --configure --daemon=no syncURL=https://www.googleapis.com/.well-known/carddav proxyHost=http://proxy.vlan13.01.org:3128 useProxy=1 username=goa:syncevolution.list@gmail.com loglevel=4 backend=carddav printChanges=0 dumpData=0 target-config@client-test-googlecontacts carddav
[INFO] carddav: configuring datastore with sync mode 'two-way'
+ 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
++ echo evolution-contacts=eds_contact
++ sed -e 's/.*=//'
+ name=eds_contact
+ for i in 1 2
+ databasename=Test_eds_contact_1
+ ./syncevolution --daemon=no --print-databases backend=evolution-contacts
+ grep Test_eds_contact_1
Test_eds_contact_1 (1303826927.6946.21@mob-sync2)
+ echo evolution-contacts: Test_eds_contact_1 exists
evolution-contacts: Test_eds_contact_1 exists
+ for i in 1 2
+ databasename=Test_eds_contact_2
+ grep Test_eds_contact_2
+ ./syncevolution --daemon=no --print-databases backend=evolution-contacts
Test_eds_contact_2 (1303827279.6946.22@mob-sync2)
+ echo evolution-contacts: Test_eds_contact_2 exists
evolution-contacts: Test_eds_contact_2 exists
+ for i in evolution-contacts=eds_contact evolution-calendar=eds_event evolution-tasks=eds_task evolution-memos=eds_memo
++ sed -e 's/=.*//'
++ echo evolution-calendar=eds_event
+ 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
++ sed -e 's/=.*//'
++ echo evolution-tasks=eds_task
+ backend=evolution-tasks
++ sed -e 's/.*=//'
++ echo evolution-tasks=eds_task
+ name=eds_task
+ for i in 1 2
+ databasename=Test_eds_task_1
+ grep Test_eds_task_1
+ ./syncevolution --daemon=no --print-databases backend=evolution-tasks
Test_eds_task_1 (1303829357.6946.35@mob-sync2)
+ echo evolution-tasks: Test_eds_task_1 exists
evolution-tasks: Test_eds_task_1 exists
+ for i in 1 2
+ databasename=Test_eds_task_2
+ ./syncevolution --daemon=no --print-databases backend=evolution-tasks
+ grep Test_eds_task_2
Test_eds_task_2 (1303829493.6946.36@mob-sync2)
+ echo evolution-tasks: Test_eds_task_2 exists
evolution-tasks: Test_eds_task_2 exists
+ for i in evolution-contacts=eds_contact evolution-calendar=eds_event evolution-tasks=eds_task evolution-memos=eds_memo
++ sed -e 's/=.*//'
++ echo evolution-memos=eds_memo
+ backend=evolution-memos
++ sed -e 's/.*=//'
++ echo evolution-memos=eds_memo
+ name=eds_memo
+ for i in 1 2
+ databasename=Test_eds_memo_1
+ ./syncevolution --daemon=no --print-databases backend=evolution-memos
+ grep Test_eds_memo_1
Test_eds_memo_1 (1303828148.6946.31@mob-sync2)
+ echo evolution-memos: Test_eds_memo_1 exists
evolution-memos: Test_eds_memo_1 exists
+ for i in 1 2
+ databasename=Test_eds_memo_2
+ ./syncevolution --daemon=no --print-databases backend=evolution-memos
+ grep Test_eds_memo_2
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-106 line 100: RET=0
wrappercheck-106 line 101: set -e
wrappercheck-106 line 107: set +x
*** killing and waiting for /usr/libexec/activesyncd
wrappercheck-106 line 108: kill -INT -109
wrappercheck-106 line 108: kill -TERM -109
wrappercheck-106 line 108: kill -TERM 109
wrappercheck-106 line 110: KILL_PID=366
wrappercheck-106 line 115: set +e
wrappercheck-106 line 116: wait 109
wrappercheck-106 line 109: perl -e 'sleep(60); kill(9, -109);'
wrappercheck-106 line 117: SUBRET=143
wrappercheck-106 line 118: case $SUBRET in
wrappercheck-106 line 118: SUBRET=0
wrappercheck-106 line 120: SUBRET=0
wrappercheck-106 line 121: '[' 366 ']'
wwrappercheck-106 line 122: LC_ALL=C
wwrappercheck-106 line 122: kill -KILL 366
wrappercheck-106 line 122: msg=
wrappercheck-106 line 123: echo ''
wrappercheck-106 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-106 line 127: echo ''
wrappercheck-106 line 129: wait 366
wrappercheck-106 line 131: set -e
wrappercheck-106 line 132: '[' 0 = 0 ']'
wrappercheck-106 line 133: RET=0
wrappercheck-106 line 136: exit 0
wrappercheck-102 line 100: RET=0
wrappercheck-102 line 101: set -e
wrappercheck-102 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-calendar-factory
wrappercheck-102 line 108: kill -INT -104
wrappercheck-102 line 108: kill -TERM -104
wrappercheck-102 line 108: kill -TERM 104
wrappercheck-102 line 110: KILL_PID=371
wrappercheck-102 line 115: set +e
wrappercheck-102 line 116: wait 104
wrappercheck-102 line 117: SUBRET=143
wrappercheck-102 line 118: case $SUBRET in
wrappercheck-102 line 118: SUBRET=0
wrappercheck-102 line 120: SUBRET=0
wrappercheck-102 line 121: '[' 371 ']'
wrappercheck-102 line 109: perl -e 'sleep(60); kill(9, -104);'
wwrappercheck-102 line 122: LC_ALL=C
wwrappercheck-102 line 122: kill -KILL 371
wrappercheck-102 line 122: msg=
wrappercheck-102 line 123: echo ''
wrappercheck-102 line 123: grep -q 'No such process'
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 371 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-102 line 127: echo ''
wrappercheck-102 line 129: wait 371
wrappercheck-102 line 131: set -e
wrappercheck-102 line 132: '[' 0 = 0 ']'
wrappercheck-102 line 133: RET=0
wrappercheck-102 line 136: exit 0
wrappercheck-82 line 100: RET=0
wrappercheck-82 line 101: set -e
wrappercheck-82 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-addressbook-factory
wrappercheck-82 line 108: kill -INT -84
wrappercheck-82 line 108: kill -TERM -84
wrappercheck-82 line 108: kill -TERM 84
wrappercheck-82 line 110: KILL_PID=376
wrappercheck-82 line 115: set +e
wrappercheck-82 line 116: wait 84
wrappercheck-82 line 109: perl -e 'sleep(60); kill(9, -84);'
wrappercheck-82 line 117: SUBRET=143
wrappercheck-82 line 118: case $SUBRET in
wrappercheck-82 line 118: SUBRET=0
wrappercheck-82 line 120: SUBRET=0
wrappercheck-82 line 121: '[' 376 ']'
wwrappercheck-82 line 122: LC_ALL=C
wwrappercheck-82 line 122: kill -KILL 376
wrappercheck-82 line 122: msg=
wrappercheck-82 line 123: echo ''
wrappercheck-82 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-82 line 127: echo ''
wrappercheck-82 line 129: wait 376
wrappercheck-82 line 131: set -e
wrappercheck-82 line 132: '[' 0 = 0 ']'
wrappercheck-82 line 133: RET=0
wrappercheck-82 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 /usr/lib/evolution/evolution-source-registry
wrappercheck-19 line 108: kill -INT -24
wrappercheck-19 line 108: kill -TERM -24
wrappercheck-19 line 108: kill -TERM 24
wrappercheck-19 line 110: KILL_PID=381
wrappercheck-19 line 109: perl -e 'sleep(60); kill(9, -24);'
wrappercheck-19 line 115: set +e
wrappercheck-19 line 116: wait 24
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: '[' 381 ']'
wwrappercheck-19 line 122: LC_ALL=C
wwrappercheck-19 line 122: kill -KILL 381
wrappercheck-19 line 122: msg=
wrappercheck-19 line 123: grep -q 'No such process'
wrappercheck-19 line 123: echo ''
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 381 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-19 line 127: echo ''
wrappercheck-19 line 129: wait 381
wrappercheck-19 line 131: set -e
wrappercheck-19 line 132: '[' 0 = 0 ']'
wrappercheck-19 line 133: RET=0
wrappercheck-19 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: grep -q 'No such process'
wrappercheck-15 line 123: echo ''
/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.lNJnMECdiB
Fri Jan 5 15:31:39 2018 UTC (+ 21.6s / 34.3s) === cleaning up ===
runtests.py-2280 Fri Jan 5 15:31:39 2018 UTC (+ 34.3s / 143.9s) *** ( cd /data/schroot/2018-01-05-07-10-all-prebuilt-testing-amd64/data/runtests/work/prebuilt-testing-amd64/tests/googlecontacts; export 'PATH=/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin' 'HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts' 'XDG_CONFIG_HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/config' 'XDG_DATA_HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/data' 'XDG_CACHE_HOME=/data/runtests/work/prebuilt-testing-amd64/home/googlecontacts/cache'; unset LD_LIBRARY_PATH; /data/runtests/work/sources/syncevolution/test/resources.py -j 1 -r googlecontacts -- 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=googlecontacts CLIENT_TEST_SOURCES=google_carddav,eds_contact SYNC_EVOLUTION_EVO_CALENDAR_DELAY=1 CLIENT_TEST_ALARM=1200 'CLIENT_TEST_WEBDAV=google carddav' CLIENT_TEST_NUM_ITEMS=10 CLIENT_TEST_MODE=server CLIENT_TEST_FAILURES= CLIENT_TEST_LOG= CLIENT_TEST_EVOLUTION_PREFIX=Test_ schroot -d /data/runtests/work/prebuilt-testing-amd64/tests/googlecontacts -r -p -c 2018-01-05-07-10-all-prebuilt-testing-amd64 -- env DBUS_SESSION_SH_SYSTEM_BUS=1 /unshare --pid --mount-proc --fork -- /data/runtests/work/sources/syncevolution/test/dbus-session.sh /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log dbus-monitor.log dbus-monitor interface=org.freedesktop.DBus -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:$PATH: /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems )
Fri Jan 5 15:31:39 2018 UTC (+ 0.0s / 0.0s) === locking resource(s) ['googlecontacts'] ===
Fri Jan 5 15:31:39 2018 UTC (+ 0.0s / 0.0s) property changed: status = acquired
Fri Jan 5 15:31:39 2018 UTC (+ 0.0s / 0.0s) using jobserver
Fri Jan 5 15:31:39 2018 UTC (+ 0.0s / 0.0s) === allocating 1 job slot(s) ===
Fri Jan 5 15:31:40 2018 UTC (+ 0.9s / 0.9s) === allocated 1 job slot(s) ===
W: line 4 [2018-01-05-07-10-all-release-eas-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-release-eas-stretch-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-xenial-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-prebuilt-testing-amd64] custom-session-purgeable: Configuration key name ‘custom-session-purgeable’ is not a permitted name.
W: line 4 [2018-01-05-07-10-all-cppcheck] 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-amd64 chroot] Running command: “env DBUS_SESSION_SH_SYSTEM_BUS=1 /unshare --pid --mount-proc --fork -- /data/runtests/work/sources/syncevolution/test/dbus-session.sh /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log dbus-monitor.log dbus-monitor interface=org.freedesktop.DBus -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-source-registry.log --daemon-sleep 5 --wait-for-dbus-daemon org.gnome.evolution.dataserver.Sources /usr/lib/evolution/evolution-source-registry -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-addressbook-factory.log --wait-for-dbus-daemon org.gnome.evolution.dataserver.AddressBook /usr/lib/evolution/evolution-addressbook-factory --keep-running -- /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems”
gnome-keyring-daemon: insufficient process capabilities, unsecure memory might get used
** Message: couldn't access control socket: /tmp/tmp.z5emRiKatE/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: '[' 35 -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: '[' 33 -gt 1 ']'
wrappercheck-19 line 28: '[' dbus-monitor '!=' -- ']'
wrappercheck-19 line 29: case "$1" in
wrappercheck-19 line 50: break
wrappercheck-19 line 56: '[' 33 -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: '[' 32 -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: '[' 31 -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 75: '[' dbus-monitor.log ']'
wrappercheck-19 line 75: '[' '' ']'
wrappercheck-19 line 70: exec
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 LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Source::google_carddav::testImport 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: '[' 29 -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: '[' 27 -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: '[' 25 -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: '[' 23 -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: '[' 23 -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: '[' 22 -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=30
wrappercheck-25 line 73: PIDS+=30
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'
wrappercheck-25 line 93: kill -0 30
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 LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-82 line 16: PIDS=
wrappercheck-82 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-82 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-82 line 21: DAEMON_LOG=
wrappercheck-82 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-82 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-82 line 25: declare -a BACKGROUND
wrappercheck-82 line 26: declare -a ENV
wrappercheck-82 line 28: '[' 20 -gt 1 ']'
wrappercheck-82 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-82 line 29: case "$1" in
wrappercheck-82 line 31: shift
wrappercheck-82 line 32: DAEMON_LOG=evolution-addressbook-factory.log
wrappercheck-82 line 53: shift
wrappercheck-82 line 28: '[' 18 -gt 1 ']'
wrappercheck-82 line 28: '[' --wait-for-dbus-daemon '!=' -- ']'
wrappercheck-82 line 29: case "$1" in
wrappercheck-82 line 35: shift
wrappercheck-82 line 36: WAIT_FOR_DBUS_DAEMON=org.gnome.evolution.dataserver.AddressBook
wrappercheck-82 line 53: shift
wrappercheck-82 line 28: '[' 16 -gt 1 ']'
wrappercheck-82 line 28: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-82 line 29: case "$1" in
wrappercheck-82 line 50: break
wrappercheck-82 line 56: '[' 16 -gt 1 ']'
wrappercheck-82 line 56: '[' /usr/lib/evolution/evolution-addressbook-factory '!=' -- ']'
wrappercheck-82 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-addressbook-factory
wrappercheck-82 line 58: shift
wrappercheck-82 line 56: '[' 15 -gt 1 ']'
wrappercheck-82 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-82 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-82 line 58: shift
wrappercheck-82 line 56: '[' 14 -gt 1 ']'
wrappercheck-82 line 56: '[' -- '!=' -- ']'
wrappercheck-82 line 60: shift
wrappercheck-82 line 62: '[' evolution-addressbook-factory.log ']'
wrappercheck-82 line 62: '[' '' ']'
wrappercheck-82 line 66: set +x
*** starting /usr/lib/evolution/evolution-addressbook-factory as background daemon, output to evolution-addressbook-factory.log
wrappercheck-82 line 72: BACKGROUND_PID=84
wrappercheck-82 line 73: PIDS+=84
wrappercheck-82 line 75: '[' evolution-addressbook-factory.log ']'
wrappercheck-82 line 70: set -x
wrappercheck-82 line 75: '[' '' ']'
wrappercheck-82 line 70: exec
wrappercheck-82 line 84: '[' org.gnome.evolution.dataserver.AddressBook ']'
wrappercheck-82 line 85: set +x
*** waiting for daemon to connect to D-Bus as 'org.gnome.evolution.dataserver.AddressBook'
wrappercheck-82 line 93: kill -0 84
wrappercheck-82 line 94: set +e
wrappercheck-82 line 95: '[' '' ']'
wrappercheck-82 line 99: set -x
wrappercheck-82 line 99: /data/runtests/work/sources/syncevolution/test/wrappercheck.sh --daemon-log evolution-calendar-factory.log /usr/lib/evolution/evolution-calendar-factory --keep-running -- env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems
+ PS4='wrappercheck-$$ line ${LINENO}: '
wrappercheck-102 line 16: PIDS=
wrappercheck-102 line 18: trap '[ "" ] && kill -TERM ' TERM
wrappercheck-102 line 19: trap '[ "" ] && kill -INT ' INT
wrappercheck-102 line 21: DAEMON_LOG=
wrappercheck-102 line 22: WAIT_FOR_DAEMON_OUTPUT=
wrappercheck-102 line 23: WAIT_FOR_DBUS_DAEMON=
wrappercheck-102 line 25: declare -a BACKGROUND
wrappercheck-102 line 26: declare -a ENV
wrappercheck-102 line 28: '[' 12 -gt 1 ']'
wrappercheck-102 line 28: '[' --daemon-log '!=' -- ']'
wrappercheck-102 line 29: case "$1" in
wrappercheck-102 line 31: shift
wrappercheck-102 line 32: DAEMON_LOG=evolution-calendar-factory.log
wrappercheck-102 line 53: shift
wrappercheck-102 line 28: '[' 10 -gt 1 ']'
wrappercheck-102 line 28: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-102 line 29: case "$1" in
wrappercheck-102 line 50: break
wrappercheck-102 line 56: '[' 10 -gt 1 ']'
wrappercheck-102 line 56: '[' /usr/lib/evolution/evolution-calendar-factory '!=' -- ']'
wrappercheck-102 line 57: BACKGROUND[${#BACKGROUND[*]}]=/usr/lib/evolution/evolution-calendar-factory
wrappercheck-102 line 58: shift
wrappercheck-102 line 56: '[' 9 -gt 1 ']'
wrappercheck-102 line 56: '[' --keep-running '!=' -- ']'
wrappercheck-102 line 57: BACKGROUND[${#BACKGROUND[*]}]=--keep-running
wrappercheck-102 line 58: shift
wrappercheck-102 line 56: '[' 8 -gt 1 ']'
wrappercheck-102 line 56: '[' -- '!=' -- ']'
wrappercheck-102 line 60: shift
wrappercheck-102 line 62: '[' evolution-calendar-factory.log ']'
wrappercheck-102 line 62: '[' '' ']'
wrappercheck-102 line 66: set +x
*** starting /usr/lib/evolution/evolution-calendar-factory as background daemon, output to evolution-calendar-factory.log
wrappercheck-102 line 72: BACKGROUND_PID=104
wrappercheck-102 line 73: PIDS+=104
wrappercheck-102 line 70: set -x
wrappercheck-102 line 75: '[' evolution-calendar-factory.log ']'
wrappercheck-102 line 75: '[' '' ']'
wrappercheck-102 line 70: exec
wrappercheck-102 line 84: '[' '' ']'
wrappercheck-102 line 93: kill -0 104
wrappercheck-102 line 94: set +e
wrappercheck-102 line 95: '[' '' ']'
wrappercheck-102 line 99: set -x
wrappercheck-102 line 99: env LD_LIBRARY_PATH=build-synthesis/src/.libs:.libs:syncevo/.libs:gdbus/.libs:gdbusxx/.libs: PATH=backends/webdav:.:/home/nightly/bin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/testing:/usr/sbin:/sbin:/home/nightly/bin:/usr/local/bin:/usr/bin:/bin:/usr/games:/usr/lib/mit/bin:/usr/lib/mit/sbin: /data/runtests/work/sources/syncevolution/test/valgrindcheck.sh ./client-test Client::Source::google_carddav::testImport 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-amd64/tests/googlecontacts/valgrind.p107.c%p.out ./client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems
Client::Source::google_carddav::testImport okay
sess: Destroying session.
Client::Sync::eds_contact::testItems okay
OKvalgrindcheck (107): './client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems' (111): returned 0
==111== Memcheck, a memory error detector
==111== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==111== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==111== Command: ./client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems
==111== Parent PID: 107
==111==
==111==
==111== HEAP SUMMARY:
==111== in use at exit: 431,316 bytes in 4,126 blocks
==111== total heap usage: 115,578 allocs, 111,452 frees, 15,366,042 bytes allocated
==111==
==111== LEAK SUMMARY:
==111== definitely lost: 0 bytes in 0 blocks
==111== indirectly lost: 0 bytes in 0 blocks
==111== possibly lost: 96 bytes in 1 blocks
==111== still reachable: 214,181 bytes in 678 blocks
==111== of which reachable via heuristic:
==111== newarray : 5,800 bytes in 17 blocks
==111== suppressed: 217,039 bytes in 3,447 blocks
==111== Rerun with --leak-check=full to see details of leaked memory
==111==
==111== For counts of detected and suppressed errors, rerun with: -v
==111== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0)
==119== Memcheck, a memory error detector
==119== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==119== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==119== Command: ./client-test Client::Source::google_carddav::testImport
==119== Parent PID: 111
==119==
==119==
==119== HEAP SUMMARY:
==119== in use at exit: 508,181 bytes in 5,088 blocks
==119== total heap usage: 213,974 allocs, 208,886 frees, 38,827,252 bytes allocated
==119==
==119== LEAK SUMMARY:
==119== definitely lost: 0 bytes in 0 blocks
==119== indirectly lost: 0 bytes in 0 blocks
==119== possibly lost: 960 bytes in 3 blocks
==119== still reachable: 226,196 bytes in 848 blocks
==119== of which reachable via heuristic:
==119== length64 : 728 bytes in 14 blocks
==119== newarray : 5,992 bytes in 29 blocks
==119== suppressed: 270,041 bytes in 4,155 blocks
==119== Rerun with --leak-check=full to see details of leaked memory
==119==
==119== For counts of detected and suppressed errors, rerun with: -v
==119== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0)
==119== could not unlink /tmp/vgdb-pipe-from-vgdb-to-119-by-nightly-on-syncev
==119== could not unlink /tmp/vgdb-pipe-to-vgdb-from-119-by-nightly-on-syncev
==119== could not unlink /tmp/vgdb-pipe-shared-mem-vgdb-119-by-nightly-on-syncev
==124== Memcheck, a memory error detector
==124== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==124== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==124== Command: ./client-test Client::Source::google_carddav::testImport
==124== Parent PID: 119
==124==
==132== Memcheck, a memory error detector
==132== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==132== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==132== Command: ./client-test Client::Sync::eds_contact::testItems
==132== Parent PID: 111
==132==
==132==
==132== HEAP SUMMARY:
==132== in use at exit: 3,098,955 bytes in 30,569 blocks
==132== total heap usage: 2,073,295 allocs, 2,042,726 frees, 217,945,169 bytes allocated
==132==
==132== LEAK SUMMARY:
==132== definitely lost: 0 bytes in 0 blocks
==132== indirectly lost: 0 bytes in 0 blocks
==132== possibly lost: 960 bytes in 3 blocks
==132== still reachable: 2,453,395 bytes in 21,654 blocks
==132== of which reachable via heuristic:
==132== length64 : 4,832 bytes in 77 blocks
==132== newarray : 6,296 bytes in 48 blocks
==132== suppressed: 554,952 bytes in 8,254 blocks
==132== Rerun with --leak-check=full to see details of leaked memory
==132==
==132== For counts of detected and suppressed errors, rerun with: -v
==132== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0)
==132== could not unlink /tmp/vgdb-pipe-from-vgdb-to-132-by-nightly-on-syncev
==132== could not unlink /tmp/vgdb-pipe-to-vgdb-from-132-by-nightly-on-syncev
==132== could not unlink /tmp/vgdb-pipe-shared-mem-vgdb-132-by-nightly-on-syncev
==157== Memcheck, a memory error detector
==157== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==157== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==157== Command: /usr/libexec/syncevo-local-sync
==157== Parent PID: 132
==157==
==157==
==157== HEAP SUMMARY:
==157== in use at exit: 2,689,894 bytes in 26,070 blocks
==157== total heap usage: 743,666 allocs, 717,596 frees, 81,381,975 bytes allocated
==157==
==157== LEAK SUMMARY:
==157== definitely lost: 0 bytes in 0 blocks
==157== indirectly lost: 0 bytes in 0 blocks
==157== possibly lost: 528 bytes in 2 blocks
==157== still reachable: 2,404,468 bytes in 21,695 blocks
==157== of which reachable via heuristic:
==157== stdstring : 52 bytes in 1 blocks
==157== length64 : 896 bytes in 17 blocks
==157== newarray : 5,976 bytes in 28 blocks
==157== suppressed: 272,746 bytes in 4,280 blocks
==157== Rerun with --leak-check=full to see details of leaked memory
==157==
==157== For counts of detected and suppressed errors, rerun with: -v
==157== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0)
==157== could not unlink /tmp/vgdb-pipe-from-vgdb-to-157-by-nightly-on-syncev
==157== could not unlink /tmp/vgdb-pipe-to-vgdb-from-157-by-nightly-on-syncev
==157== could not unlink /tmp/vgdb-pipe-shared-mem-vgdb-157-by-nightly-on-syncev
==177== Memcheck, a memory error detector
==177== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==177== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==177== Command: /usr/libexec/syncevo-local-sync
==177== Parent PID: 132
==177==
==177==
==177== HEAP SUMMARY:
==177== in use at exit: 2,689,830 bytes in 26,068 blocks
==177== total heap usage: 337,795 allocs, 311,727 frees, 49,516,901 bytes allocated
==177==
==177== LEAK SUMMARY:
==177== definitely lost: 0 bytes in 0 blocks
==177== indirectly lost: 0 bytes in 0 blocks
==177== possibly lost: 528 bytes in 2 blocks
==177== still reachable: 2,404,468 bytes in 21,695 blocks
==177== of which reachable via heuristic:
==177== stdstring : 52 bytes in 1 blocks
==177== length64 : 896 bytes in 17 blocks
==177== newarray : 5,976 bytes in 28 blocks
==177== suppressed: 272,682 bytes in 4,278 blocks
==177== Rerun with --leak-check=full to see details of leaked memory
==177==
==177== For counts of detected and suppressed errors, rerun with: -v
==177== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0)
==177== could not unlink /tmp/vgdb-pipe-from-vgdb-to-177-by-nightly-on-syncev
==177== could not unlink /tmp/vgdb-pipe-to-vgdb-from-177-by-nightly-on-syncev
==177== could not unlink /tmp/vgdb-pipe-shared-mem-vgdb-177-by-nightly-on-syncev
==208== Memcheck, a memory error detector
==208== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==208== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==208== Command: ./client-test Client::Sync::eds_contact::testItems
==208== Parent PID: 132
==208==
==216== Memcheck, a memory error detector
==216== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==216== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==216== Command: /usr/libexec/syncevo-local-sync
==216== Parent PID: 132
==216==
==216==
==216== HEAP SUMMARY:
==216== in use at exit: 2,689,846 bytes in 26,070 blocks
==216== total heap usage: 591,618 allocs, 565,548 frees, 70,252,328 bytes allocated
==216==
==216== LEAK SUMMARY:
==216== definitely lost: 0 bytes in 0 blocks
==216== indirectly lost: 0 bytes in 0 blocks
==216== possibly lost: 528 bytes in 2 blocks
==216== still reachable: 2,404,468 bytes in 21,695 blocks
==216== of which reachable via heuristic:
==216== stdstring : 52 bytes in 1 blocks
==216== length64 : 896 bytes in 17 blocks
==216== newarray : 5,976 bytes in 28 blocks
==216== suppressed: 272,698 bytes in 4,280 blocks
==216== Rerun with --leak-check=full to see details of leaked memory
==216==
==216== For counts of detected and suppressed errors, rerun with: -v
==216== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0)
==227== Memcheck, a memory error detector
==227== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==227== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==227== Command: /usr/libexec/syncevo-local-sync
==227== Parent PID: 132
==227==
==227==
==227== HEAP SUMMARY:
==227== in use at exit: 2,689,854 bytes in 26,070 blocks
==227== total heap usage: 654,808 allocs, 628,738 frees, 74,398,122 bytes allocated
==227==
==227== LEAK SUMMARY:
==227== definitely lost: 0 bytes in 0 blocks
==227== indirectly lost: 0 bytes in 0 blocks
==227== possibly lost: 528 bytes in 2 blocks
==227== still reachable: 2,404,468 bytes in 21,695 blocks
==227== of which reachable via heuristic:
==227== stdstring : 52 bytes in 1 blocks
==227== length64 : 896 bytes in 17 blocks
==227== newarray : 5,976 bytes in 28 blocks
==227== suppressed: 272,706 bytes in 4,280 blocks
==227== Rerun with --leak-check=full to see details of leaked memory
==227==
==227== For counts of detected and suppressed errors, rerun with: -v
==227== ERROR SUMMARY: 0 errors from 0 contexts (suppressed: 0 from 0)
==253== Memcheck, a memory error detector
==253== Copyright (C) 2002-2017, and GNU GPL'd, by Julian Seward et al.
==253== Using Valgrind-3.13.0 and LibVEX; rerun with -h for copyright info
==253== Command: ./client-test Client::Sync::eds_contact::testItems
==253== Parent PID: 132
==253==
valgrindcheck: ./client-test Client::Source::google_carddav::testImport Client::Sync::eds_contact::testItems: final result 0
wrappercheck-102 line 100: RET=0
wrappercheck-102 line 101: set -e
wrappercheck-102 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-calendar-factory
wrappercheck-102 line 108: kill -INT -104
wrappercheck-102 line 108: kill -TERM -104
wrappercheck-102 line 108: kill -TERM 104
wrappercheck-102 line 110: KILL_PID=395
wrappercheck-102 line 115: set +e
wrappercheck-102 line 116: wait 104
wrappercheck-102 line 117: SUBRET=143
wrappercheck-102 line 118: case $SUBRET in
wrappercheck-102 line 118: SUBRET=0
wrappercheck-102 line 120: SUBRET=0
wrappercheck-102 line 121: '[' 395 ']'
wwrappercheck-102 line 122: LC_ALL=C
wwrappercheck-102 line 122: kill -KILL 395
wrappercheck-102 line 122: msg=
wrappercheck-102 line 123: echo ''
wrappercheck-102 line 123: grep -q 'No such process'
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 395 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-102 line 127: echo ''
wrappercheck-102 line 129: wait 395
wrappercheck-102 line 131: set -e
wrappercheck-102 line 132: '[' 0 = 0 ']'
wrappercheck-102 line 133: RET=0
wrappercheck-102 line 136: exit 0
wrappercheck-82 line 100: RET=0
wrappercheck-82 line 101: set -e
wrappercheck-82 line 107: set +x
*** killing and waiting for /usr/lib/evolution/evolution-addressbook-factory
wrappercheck-82 line 108: kill -INT -84
wrappercheck-82 line 108: kill -TERM -84
wrappercheck-82 line 108: kill -TERM 84
wrappercheck-82 line 110: KILL_PID=400
wrappercheck-82 line 109: perl -e 'sleep(60); kill(9, -84);'
wrappercheck-82 line 115: set +e
wrappercheck-82 line 116: wait 84
wrappercheck-82 line 117: SUBRET=143
wrappercheck-82 line 118: case $SUBRET in
wrappercheck-82 line 118: SUBRET=0
wrappercheck-82 line 120: SUBRET=0
wrappercheck-82 line 121: '[' 400 ']'
wwrappercheck-82 line 122: LC_ALL=C
wwrappercheck-82 line 122: kill -KILL 400
wrappercheck-82 line 122: msg=
wrappercheck-82 line 123: grep -q 'No such process'
wrappercheck-82 line 123: echo ''
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 400 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-82 line 127: echo ''
wrappercheck-82 line 129: wait 400
wrappercheck-82 line 131: set -e
wrappercheck-82 line 132: '[' 0 = 0 ']'
wrappercheck-82 line 133: RET=0
wrappercheck-82 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 -30
wrappercheck-25 line 108: kill -TERM -30
wrappercheck-25 line 108: kill -TERM 30
wrappercheck-25 line 110: KILL_PID=405
wrappercheck-25 line 115: set +e
wrappercheck-25 line 116: wait 30
wrappercheck-25 line 109: perl -e 'sleep(60); kill(9, -30);'
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: '[' 405 ']'
wwrappercheck-25 line 122: LC_ALL=C
wwrappercheck-25 line 122: kill -KILL 405
wrappercheck-25 line 122: msg=
wrappercheck-25 line 123: grep -q 'No such process'
wrappercheck-25 line 123: echo ''
/data/runtests/work/sources/syncevolution/test/wrappercheck.sh: line 130: 405 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-25 line 127: echo ''
wrappercheck-25 line 129: wait 405
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=410
wrappercheck-19 line 115: set +e
wrappercheck-19 line 109: perl -e 'sleep(60); kill(9, -22);'
wrappercheck-19 line 116: wait 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: '[' 410 ']'
wwrappercheck-19 line 122: LC_ALL=C
wwrappercheck-19 line 122: kill -KILL 410
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: 410 Killed perl -e "sleep(60); kill(9, -$BACKGROUND_PID);"
wrappercheck-19 line 127: echo ''
wrappercheck-19 line 129: wait 410
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.z5emRiKatE
Fri Jan 5 15:45:58 2018 UTC (+ 858.5s / 859.4s) === cleaning up ===