[DEBUG 00:00:00] *** starting Client::Source::file_event::LinkedItemsWithVALARM::testLinkedItemsInsertBothUpdateChild ***
[DEBUG 00:00:00] ClientTest.cpp:2781: starting CPPUNIT_ASSERT(off != test.npos)
[DEBUG 00:00:00] ClientTest.cpp:2781: ending CPPUNIT_ASSERT(off != test.npos)
[DEBUG 00:00:00] ClientTest.cpp:2784: starting CPPUNIT_ASSERT(end != test.npos)
[DEBUG 00:00:00] ClientTest.cpp:2784: ending CPPUNIT_ASSERT(end != test.npos)
[DEBUG 00:00:00] ClientTest.cpp:2442: starting deleteAll(createSourceA)
[DEBUG 00:00:00] ClientTest.cpp:802: starting CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:00] ClientTest.cpp:802: ending CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:00] ClientTest.cpp:807: starting source.reset(createSource())
[DEBUG 00:00:00] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:00] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:00]    sync = disabled (set)
[DEBUG 00:00:00]    uri = cal2 (set)
[DEBUG 00:00:00]    backend = file (set)
[DEBUG 00:00:00]    syncFormat =  (default)
[DEBUG 00:00:00]    forceSyncFormat = 0 (default)
[DEBUG 00:00:00]    database = Test_file_event_1 (set)
[DEBUG 00:00:00]    databaseFormat =  (default)
[DEBUG 00:00:00]    databaseUser =  (default)
[DEBUG 00:00:00]    databasePassword =  (default)
[DEBUG 00:00:00] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:00] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:00] file_event: slow sync or testing, do full item scan to detect changes
[DEBUG 00:00:00] ClientTest.cpp:807: ending source.reset(createSource())
[DEBUG 00:00:00] ClientTest.cpp:807: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:807: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:810: starting source->removeAllItems()
[DEBUG 00:00:00] ClientTest.cpp:810: ending source->removeAllItems()
[DEBUG 00:00:00] ClientTest.cpp:810: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:810: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:811: starting source.reset()
[DEBUG 00:00:00] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:00] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:00] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:00] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:00] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:00] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:00] ClientTest.cpp:811: ending source.reset()
[DEBUG 00:00:00] ClientTest.cpp:814: starting source.reset(createSource())
[DEBUG 00:00:00] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:00] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:00]    sync = disabled (set)
[DEBUG 00:00:00]    uri = cal2 (set)
[DEBUG 00:00:00]    backend = file (set)
[DEBUG 00:00:00]    syncFormat =  (default)
[DEBUG 00:00:00]    forceSyncFormat = 0 (default)
[DEBUG 00:00:00]    database = Test_file_event_1 (set)
[DEBUG 00:00:00]    databaseFormat =  (default)
[DEBUG 00:00:00]    databaseUser =  (default)
[DEBUG 00:00:00]    databasePassword =  (default)
[DEBUG 00:00:00] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:00] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:00] file_event: using full item scan to detect changes
[DEBUG 00:00:00] ClientTest.cpp:814: ending source.reset(createSource())
[DEBUG 00:00:00] ClientTest.cpp:814: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:814: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:818: starting CPPUNIT_ASSERT_MESSAGE(("should be empty now"), ((countItems(source.get()) == 0)))
[DEBUG 00:00:00] ClientTest.cpp:818: ending CPPUNIT_ASSERT_MESSAGE(("should be empty now"), ((countItems(source.get()) == 0)))
[DEBUG 00:00:00] ClientTest.cpp:818: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:818: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:819: starting CPPUNIT_ASSERT_EQUAL((0),(countNewItems(source.get())))
[DEBUG 00:00:00] ClientTest.cpp:819: ending CPPUNIT_ASSERT_EQUAL((0),(countNewItems(source.get())))
[DEBUG 00:00:00] ClientTest.cpp:820: starting CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(source.get())))
[DEBUG 00:00:00] ClientTest.cpp:820: ending CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(source.get())))
[DEBUG 00:00:00] ClientTest.cpp:821: starting CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(source.get())))
[DEBUG 00:00:00] ClientTest.cpp:821: ending CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(source.get())))
[DEBUG 00:00:00] ClientTest.cpp:391: starting reset(__null)
[DEBUG 00:00:00] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:00] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:00] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:00] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:00] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:00] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:00] ClientTest.cpp:391: ending reset(__null)
[DEBUG 00:00:00] ClientTest.cpp:2442: ending deleteAll(createSourceA)
[DEBUG 00:00:00] ClientTest.cpp:2448: starting copy.reset(createSourceB())
[DEBUG 00:00:00] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_B
[DEBUG 00:00:00] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:00]    sync = disabled (set)
[DEBUG 00:00:00]    uri = cal2 (set)
[DEBUG 00:00:00]    backend = file (set)
[DEBUG 00:00:00]    syncFormat =  (default)
[DEBUG 00:00:00]    forceSyncFormat = 0 (default)
[DEBUG 00:00:00]    database = Test_file_event_1 (set)
[DEBUG 00:00:00]    databaseFormat =  (default)
[DEBUG 00:00:00]    databaseUser =  (default)
[DEBUG 00:00:00]    databasePassword =  (default)
[DEBUG 00:00:00] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:00] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:00] file_event: slow sync or testing, do full item scan to detect changes
[DEBUG 00:00:00] ClientTest.cpp:2448: ending copy.reset(createSourceB())
[DEBUG 00:00:00] ClientTest.cpp:2448: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:00] ClientTest.cpp:2448: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:00] ClientTest.cpp:2449: starting CPPUNIT_ASSERT_EQUAL((0),(countItems(copy.get())))
[DEBUG 00:00:00] ClientTest.cpp:2449: ending CPPUNIT_ASSERT_EQUAL((0),(countItems(copy.get())))
[DEBUG 00:00:00] ClientTest.cpp:2449: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:00] ClientTest.cpp:2449: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:00] ClientTest.cpp:2450: starting copy.reset()
[DEBUG 00:00:00] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:00] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:00] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:00] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:00] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:00] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:00] ClientTest.cpp:2450: ending copy.reset()
[DEBUG 00:00:00] ClientTest.cpp:2453: starting parent = insert(createSourceA, items[0], false, &parentData)
[DEBUG 00:00:00] ClientTest.cpp:669: starting source.reset(createSource())
[DEBUG 00:00:00] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:00] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:00]    sync = disabled (set)
[DEBUG 00:00:00]    uri = cal2 (set)
[DEBUG 00:00:00]    backend = file (set)
[DEBUG 00:00:00]    syncFormat =  (default)
[DEBUG 00:00:00]    forceSyncFormat = 0 (default)
[DEBUG 00:00:00]    database = Test_file_event_1 (set)
[DEBUG 00:00:00]    databaseFormat =  (default)
[DEBUG 00:00:00]    databaseUser =  (default)
[DEBUG 00:00:00]    databasePassword =  (default)
[DEBUG 00:00:00] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:00] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:00] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:00] file_event: using full item scan to detect changes
[DEBUG 00:00:00] ClientTest.cpp:669: ending source.reset(createSource())
[DEBUG 00:00:00] ClientTest.cpp:669: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:669: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:673: starting numItems = countItems(source.get())
[DEBUG 00:00:00] ClientTest.cpp:673: ending numItems = countItems(source.get())
[DEBUG 00:00:00] ClientTest.cpp:679: starting res = source->insertItemRaw("", mangled)
[DEBUG 00:00:00] ClientTest.cpp:679: ending res = source->insertItemRaw("", mangled)
[DEBUG 00:00:00] ClientTest.cpp:679: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:679: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:00] ClientTest.cpp:680: starting CPPUNIT_ASSERT(!res.m_luid.empty())
[DEBUG 00:00:00] ClientTest.cpp:680: ending CPPUNIT_ASSERT(!res.m_luid.empty())
[DEBUG 00:00:00] ClientTest.cpp:693: starting source.reset()
[DEBUG 00:00:00] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:00] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:00] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:01] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:01] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:01] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:01] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:01] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:01] ClientTest.cpp:693: ending source.reset()
[DEBUG 00:00:01] ClientTest.cpp:699: starting source.reset(createSource())
[DEBUG 00:00:01] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:01] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:01]    sync = disabled (set)
[DEBUG 00:00:01]    uri = cal2 (set)
[DEBUG 00:00:01]    backend = file (set)
[DEBUG 00:00:01]    syncFormat =  (default)
[DEBUG 00:00:01]    forceSyncFormat = 0 (default)
[DEBUG 00:00:01]    database = Test_file_event_1 (set)
[DEBUG 00:00:01]    databaseFormat =  (default)
[DEBUG 00:00:01]    databaseUser =  (default)
[DEBUG 00:00:01]    databasePassword =  (default)
[DEBUG 00:00:02] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:02] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:02] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:02] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:02] file_event: using full item scan to detect changes
[DEBUG 00:00:02] ClientTest.cpp:699: ending source.reset(createSource())
[DEBUG 00:00:02] ClientTest.cpp:699: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:02] ClientTest.cpp:699: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:02] ClientTest.cpp:701: starting CPPUNIT_ASSERT_EQUAL((numItems + ((res.m_state == ITEM_REPLACED || res.m_state == ITEM_MERGED || updated) ? 0 : 1)),(countItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:701: ending CPPUNIT_ASSERT_EQUAL((numItems + ((res.m_state == ITEM_REPLACED || res.m_state == ITEM_MERGED || updated) ? 0 : 1)),(countItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:702: starting CPPUNIT_ASSERT_EQUAL((0),(countNewItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:702: ending CPPUNIT_ASSERT_EQUAL((0),(countNewItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:703: starting CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:703: ending CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:704: starting CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:704: ending CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(source.get())))
[DEBUG 00:00:02] ClientTest.cpp:391: starting reset(__null)
[DEBUG 00:00:02] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:02] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:02] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:02] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:02] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:02] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:02] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:02] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:02] ClientTest.cpp:391: ending reset(__null)
[DEBUG 00:00:02] ClientTest.cpp:2453: ending parent = insert(createSourceA, items[0], false, &parentData)
[DEBUG 00:00:02] ClientTest.cpp:2454: starting child = insert(createSourceA, items[1], false, &childData)
[DEBUG 00:00:02] ClientTest.cpp:669: starting source.reset(createSource())
[DEBUG 00:00:02] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:02] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:02]    sync = disabled (set)
[DEBUG 00:00:02]    uri = cal2 (set)
[DEBUG 00:00:02]    backend = file (set)
[DEBUG 00:00:02]    syncFormat =  (default)
[DEBUG 00:00:02]    forceSyncFormat = 0 (default)
[DEBUG 00:00:02]    database = Test_file_event_1 (set)
[DEBUG 00:00:02]    databaseFormat =  (default)
[DEBUG 00:00:02]    databaseUser =  (default)
[DEBUG 00:00:02]    databasePassword =  (default)
[DEBUG 00:00:02] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:02] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:02] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:02] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:02] file_event: using full item scan to detect changes
[DEBUG 00:00:02] ClientTest.cpp:669: ending source.reset(createSource())
[DEBUG 00:00:02] ClientTest.cpp:669: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:02] ClientTest.cpp:669: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:02] ClientTest.cpp:673: starting numItems = countItems(source.get())
[DEBUG 00:00:02] ClientTest.cpp:673: ending numItems = countItems(source.get())
[DEBUG 00:00:02] ClientTest.cpp:679: starting res = source->insertItemRaw("", mangled)
[DEBUG 00:00:02] ClientTest.cpp:679: ending res = source->insertItemRaw("", mangled)
[DEBUG 00:00:02] ClientTest.cpp:679: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:02] ClientTest.cpp:679: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:02] ClientTest.cpp:680: starting CPPUNIT_ASSERT(!res.m_luid.empty())
[DEBUG 00:00:02] ClientTest.cpp:680: ending CPPUNIT_ASSERT(!res.m_luid.empty())
[DEBUG 00:00:02] ClientTest.cpp:693: starting source.reset()
[DEBUG 00:00:02] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:02] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:02] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:02] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:03] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:03] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:03] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:03] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:03] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:03] ClientTest.cpp:693: ending source.reset()
[DEBUG 00:00:03] ClientTest.cpp:699: starting source.reset(createSource())
[DEBUG 00:00:03] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:03] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:03]    sync = disabled (set)
[DEBUG 00:00:03]    uri = cal2 (set)
[DEBUG 00:00:03]    backend = file (set)
[DEBUG 00:00:03]    syncFormat =  (default)
[DEBUG 00:00:03]    forceSyncFormat = 0 (default)
[DEBUG 00:00:03]    database = Test_file_event_1 (set)
[DEBUG 00:00:03]    databaseFormat =  (default)
[DEBUG 00:00:03]    databaseUser =  (default)
[DEBUG 00:00:03]    databasePassword =  (default)
[DEBUG 00:00:03] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:03] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:03] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:03] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:03] file_event: using full item scan to detect changes
[DEBUG 00:00:03] ClientTest.cpp:699: ending source.reset(createSource())
[DEBUG 00:00:03] ClientTest.cpp:699: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:699: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:701: starting CPPUNIT_ASSERT_EQUAL((numItems + ((res.m_state == ITEM_REPLACED || res.m_state == ITEM_MERGED || updated) ? 0 : 1)),(countItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:701: ending CPPUNIT_ASSERT_EQUAL((numItems + ((res.m_state == ITEM_REPLACED || res.m_state == ITEM_MERGED || updated) ? 0 : 1)),(countItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:702: starting CPPUNIT_ASSERT_EQUAL((0),(countNewItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:702: ending CPPUNIT_ASSERT_EQUAL((0),(countNewItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:703: starting CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:703: ending CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:704: starting CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:704: ending CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(source.get())))
[DEBUG 00:00:03] ClientTest.cpp:391: starting reset(__null)
[DEBUG 00:00:03] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:03] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:03] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:03] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:03] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:03] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:03] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:03] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:03] ClientTest.cpp:391: ending reset(__null)
[DEBUG 00:00:03] ClientTest.cpp:2454: ending child = insert(createSourceA, items[1], false, &childData)
[DEBUG 00:00:03] ClientTest.cpp:2456: starting copy.reset(createSourceB())
[DEBUG 00:00:03] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_B
[DEBUG 00:00:03] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:03]    sync = disabled (set)
[DEBUG 00:00:03]    uri = cal2 (set)
[DEBUG 00:00:03]    backend = file (set)
[DEBUG 00:00:03]    syncFormat =  (default)
[DEBUG 00:00:03]    forceSyncFormat = 0 (default)
[DEBUG 00:00:03]    database = Test_file_event_1 (set)
[DEBUG 00:00:03]    databaseFormat =  (default)
[DEBUG 00:00:03]    databaseUser =  (default)
[DEBUG 00:00:03]    databasePassword =  (default)
[DEBUG 00:00:03] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:03] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:03] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:03] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:03] file_event: using full item scan to detect changes
[DEBUG 00:00:03] ClientTest.cpp:2456: ending copy.reset(createSourceB())
[DEBUG 00:00:03] ClientTest.cpp:2456: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2456: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2457: starting compareDatabases(copy.get(), &parentData, &childData, (void *)__null)
[DEBUG 00:00:03] ClientTest.cpp:846: starting CPPUNIT_ASSERT(config.m_dump)
[DEBUG 00:00:03] ClientTest.cpp:846: ending CPPUNIT_ASSERT(config.m_dump)
[DEBUG 00:00:03] ClientTest.cpp:863: starting CPPUNIT_ASSERT_EQUAL((0),(config.m_dump(client, copy, copyFile)))
[DEBUG 00:00:03] ClientTest.cpp:6698: starting CPPUNIT_ASSERT(source.getOperations().m_backupData)
[DEBUG 00:00:03] ClientTest.cpp:6698: ending CPPUNIT_ASSERT(source.getOperations().m_backupData)
[DEBUG 00:00:03] ClientTest.cpp:863: ending CPPUNIT_ASSERT_EQUAL((0),(config.m_dump(client, copy, copyFile)))
[DEBUG 00:00:03] ClientTest.cpp:871: starting equal = config.m_compare(client, refFile.c_str(), actualFile.c_str())
[DEBUG 00:00:03] ClientTest.cpp:871: ending equal = config.m_compare(client, refFile.c_str(), actualFile.c_str())
[DEBUG 00:00:03] ClientTest.cpp:872: starting CPPUNIT_ASSERT(!raiseAssert || equal)
[DEBUG 00:00:03] ClientTest.cpp:872: ending CPPUNIT_ASSERT(!raiseAssert || equal)
[DEBUG 00:00:03] ClientTest.cpp:2457: ending compareDatabases(copy.get(), &parentData, &childData, (void *)__null)
[DEBUG 00:00:03] ClientTest.cpp:2458: starting CPPUNIT_ASSERT_EQUAL((2),(countItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2458: ending CPPUNIT_ASSERT_EQUAL((2),(countItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2458: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2458: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2459: starting CPPUNIT_ASSERT_EQUAL((2),(countNewItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2459: ending CPPUNIT_ASSERT_EQUAL((2),(countNewItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2459: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2459: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2460: starting CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2460: ending CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2460: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2460: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2461: starting CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2461: ending CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(copy.get())))
[DEBUG 00:00:03] ClientTest.cpp:2461: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2461: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2463: starting CPPUNIT_ASSERT_EQUAL((1),(countEqual(listItems(copy.get()), child)))
[DEBUG 00:00:03] ClientTest.cpp:2463: ending CPPUNIT_ASSERT_EQUAL((1),(countEqual(listItems(copy.get()), child)))
[DEBUG 00:00:03] ClientTest.cpp:2463: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2463: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2464: starting CPPUNIT_ASSERT_EQUAL((1),(countEqual(listItems(copy.get()), parent)))
[DEBUG 00:00:03] ClientTest.cpp:2464: ending CPPUNIT_ASSERT_EQUAL((1),(countEqual(listItems(copy.get()), parent)))
[DEBUG 00:00:03] ClientTest.cpp:2464: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2464: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:03] ClientTest.cpp:2466: starting copy.reset()
[DEBUG 00:00:03] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:03] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:03] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:03] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:03] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:03] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:03] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:03] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:03] ClientTest.cpp:2466: ending copy.reset()
[DEBUG 00:00:03] ClientTest.cpp:2468: starting child = updateItem(createSourceA, config, child, items[1], &childData)
[DEBUG 00:00:03] ClientTest.cpp:715: starting CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:03] ClientTest.cpp:715: ending CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:03] ClientTest.cpp:719: starting source.reset(createSource())
[DEBUG 00:00:03] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:03] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:03]    sync = disabled (set)
[DEBUG 00:00:03]    uri = cal2 (set)
[DEBUG 00:00:03]    backend = file (set)
[DEBUG 00:00:03]    syncFormat =  (default)
[DEBUG 00:00:03]    forceSyncFormat = 0 (default)
[DEBUG 00:00:03]    database = Test_file_event_1 (set)
[DEBUG 00:00:03]    databaseFormat =  (default)
[DEBUG 00:00:03]    databaseUser =  (default)
[DEBUG 00:00:03]    databasePassword =  (default)
[DEBUG 00:00:03] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:03] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:03] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:03] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:03] file_event: using full item scan to detect changes
[DEBUG 00:00:03] ClientTest.cpp:719: ending source.reset(createSource())
[DEBUG 00:00:03] ClientTest.cpp:719: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:719: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:724: starting mangled = config.m_mangleItem(data, true, "")
[DEBUG 00:00:03] ClientTest.cpp:724: ending mangled = config.m_mangleItem(data, true, "")
[DEBUG 00:00:03] ClientTest.cpp:728: starting res = source->insertItemRaw(uid, mangled.c_str())
[DEBUG 00:00:03] ClientTest.cpp:728: ending res = source->insertItemRaw(uid, mangled.c_str())
[DEBUG 00:00:03] ClientTest.cpp:728: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:728: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:729: starting CPPUNIT_ASSERT(!res.m_luid.empty())
[DEBUG 00:00:03] ClientTest.cpp:729: ending CPPUNIT_ASSERT(!res.m_luid.empty())
[DEBUG 00:00:03] ClientTest.cpp:729: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:729: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:03] ClientTest.cpp:391: starting reset(__null)
[DEBUG 00:00:03] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:03] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:03] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:03] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:04] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:04] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:04] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:04] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:04] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:04] ClientTest.cpp:391: ending reset(__null)
[DEBUG 00:00:04] ClientTest.cpp:2468: ending child = updateItem(createSourceA, config, child, items[1], &childData)
[DEBUG 00:00:04] ClientTest.cpp:2471: starting copy.reset(createSourceB())
[DEBUG 00:00:04] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_B
[DEBUG 00:00:04] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:04]    sync = disabled (set)
[DEBUG 00:00:04]    uri = cal2 (set)
[DEBUG 00:00:04]    backend = file (set)
[DEBUG 00:00:04]    syncFormat =  (default)
[DEBUG 00:00:04]    forceSyncFormat = 0 (default)
[DEBUG 00:00:04]    database = Test_file_event_1 (set)
[DEBUG 00:00:04]    databaseFormat =  (default)
[DEBUG 00:00:04]    databaseUser =  (default)
[DEBUG 00:00:04]    databasePassword =  (default)
[DEBUG 00:00:04] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:04] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:04] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:04] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:04] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:04] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:04] file_event: using full item scan to detect changes
[DEBUG 00:00:04] ClientTest.cpp:2471: ending copy.reset(createSourceB())
[DEBUG 00:00:04] ClientTest.cpp:2471: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:04] ClientTest.cpp:2471: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:04] ClientTest.cpp:2472: starting compareDatabases(copy.get(), &parentData, &childData, (void *)__null)
[DEBUG 00:00:05] ClientTest.cpp:846: starting CPPUNIT_ASSERT(config.m_dump)
[DEBUG 00:00:05] ClientTest.cpp:846: ending CPPUNIT_ASSERT(config.m_dump)
[DEBUG 00:00:05] ClientTest.cpp:863: starting CPPUNIT_ASSERT_EQUAL((0),(config.m_dump(client, copy, copyFile)))
[DEBUG 00:00:05] ClientTest.cpp:6698: starting CPPUNIT_ASSERT(source.getOperations().m_backupData)
[DEBUG 00:00:05] ClientTest.cpp:6698: ending CPPUNIT_ASSERT(source.getOperations().m_backupData)
[DEBUG 00:00:05] ClientTest.cpp:863: ending CPPUNIT_ASSERT_EQUAL((0),(config.m_dump(client, copy, copyFile)))
[DEBUG 00:00:05] ClientTest.cpp:871: starting equal = config.m_compare(client, refFile.c_str(), actualFile.c_str())
[DEBUG 00:00:05] ClientTest.cpp:871: ending equal = config.m_compare(client, refFile.c_str(), actualFile.c_str())
[DEBUG 00:00:05] ClientTest.cpp:872: starting CPPUNIT_ASSERT(!raiseAssert || equal)
[DEBUG 00:00:05] ClientTest.cpp:872: ending CPPUNIT_ASSERT(!raiseAssert || equal)
[DEBUG 00:00:05] ClientTest.cpp:2472: ending compareDatabases(copy.get(), &parentData, &childData, (void *)__null)
[DEBUG 00:00:05] ClientTest.cpp:2473: starting CPPUNIT_ASSERT_EQUAL((2),(countItems(copy.get())))
[DEBUG 00:00:05] ClientTest.cpp:2473: ending CPPUNIT_ASSERT_EQUAL((2),(countItems(copy.get())))
[DEBUG 00:00:05] ClientTest.cpp:2473: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2473: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2474: starting CPPUNIT_ASSERT_EQUAL((0),(countNewItems(copy.get())))
[DEBUG 00:00:05] ClientTest.cpp:2474: ending CPPUNIT_ASSERT_EQUAL((0),(countNewItems(copy.get())))
[DEBUG 00:00:05] ClientTest.cpp:2474: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2474: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2475: starting CPPUNIT_ASSERT(1 <= countUpdatedItems(copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2475: ending CPPUNIT_ASSERT(1 <= countUpdatedItems(copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2475: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2475: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2476: starting CPPUNIT_ASSERT(2 >= countUpdatedItems(copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2476: ending CPPUNIT_ASSERT(2 >= countUpdatedItems(copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2476: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2476: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2477: starting CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(copy.get())))
[DEBUG 00:00:05] ClientTest.cpp:2477: ending CPPUNIT_ASSERT_EQUAL((0),(countDeletedItems(copy.get())))
[DEBUG 00:00:05] ClientTest.cpp:2477: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2477: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2479: starting CPPUNIT_ASSERT_EQUAL((1),(countEqual(listUpdatedItems(copy.get()), child)))
[DEBUG 00:00:05] ClientTest.cpp:2479: ending CPPUNIT_ASSERT_EQUAL((1),(countEqual(listUpdatedItems(copy.get()), child)))
[DEBUG 00:00:05] ClientTest.cpp:2479: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2479: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:05] ClientTest.cpp:2481: starting copy.reset()
[DEBUG 00:00:05] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:05] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:05] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:05] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:05] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:05] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:05] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:05] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:05] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:05] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:05] ClientTest.cpp:2481: ending copy.reset()
[DEBUG 00:00:05] ClientTest.cpp:2487: starting deleteItem(createSourceA, parent)
[DEBUG 00:00:05] ClientTest.cpp:827: starting CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:05] ClientTest.cpp:827: ending CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:05] ClientTest.cpp:831: starting source.reset(createSource())
[DEBUG 00:00:05] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:05] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:05]    sync = disabled (set)
[DEBUG 00:00:05]    uri = cal2 (set)
[DEBUG 00:00:05]    backend = file (set)
[DEBUG 00:00:05]    syncFormat =  (default)
[DEBUG 00:00:05]    forceSyncFormat = 0 (default)
[DEBUG 00:00:05]    database = Test_file_event_1 (set)
[DEBUG 00:00:05]    databaseFormat =  (default)
[DEBUG 00:00:05]    databaseUser =  (default)
[DEBUG 00:00:05]    databasePassword =  (default)
[DEBUG 00:00:05] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:05] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:05] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:05] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:05] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:05] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:05] file_event: using full item scan to detect changes
[DEBUG 00:00:05] ClientTest.cpp:831: ending source.reset(createSource())
[DEBUG 00:00:05] ClientTest.cpp:831: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:05] ClientTest.cpp:831: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:05] ClientTest.cpp:834: starting source->deleteItem(uid)
[DEBUG 00:00:05] ClientTest.cpp:834: ending source->deleteItem(uid)
[DEBUG 00:00:05] ClientTest.cpp:834: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:05] ClientTest.cpp:834: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:05] ClientTest.cpp:391: starting reset(__null)
[DEBUG 00:00:05] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:05] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:05] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:05] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:05] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:06] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:06] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:06] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:06] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:06] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:06] ClientTest.cpp:391: ending reset(__null)
[DEBUG 00:00:06] ClientTest.cpp:2487: ending deleteItem(createSourceA, parent)
[DEBUG 00:00:06] ClientTest.cpp:2488: starting deleteItem(createSourceA, child)
[DEBUG 00:00:06] ClientTest.cpp:827: starting CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:06] ClientTest.cpp:827: ending CPPUNIT_ASSERT(createSource.createSource)
[DEBUG 00:00:06] ClientTest.cpp:831: starting source.reset(createSource())
[DEBUG 00:00:06] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_A
[DEBUG 00:00:06] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:06]    sync = disabled (set)
[DEBUG 00:00:06]    uri = cal2 (set)
[DEBUG 00:00:06]    backend = file (set)
[DEBUG 00:00:06]    syncFormat =  (default)
[DEBUG 00:00:06]    forceSyncFormat = 0 (default)
[DEBUG 00:00:06]    database = Test_file_event_1 (set)
[DEBUG 00:00:06]    databaseFormat =  (default)
[DEBUG 00:00:06]    databaseUser =  (default)
[DEBUG 00:00:06]    databasePassword =  (default)
[DEBUG 00:00:06] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:06] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:06] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:06] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:06] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:06] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:06] file_event: using full item scan to detect changes
[DEBUG 00:00:06] ClientTest.cpp:831: ending source.reset(createSource())
[DEBUG 00:00:06] ClientTest.cpp:831: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:06] ClientTest.cpp:831: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:06] ClientTest.cpp:834: starting source->deleteItem(uid)
[DEBUG 00:00:06] ClientTest.cpp:834: ending source->deleteItem(uid)
[DEBUG 00:00:06] ClientTest.cpp:834: starting CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:06] ClientTest.cpp:834: ending CPPUNIT_ASSERT((source.get()))
[DEBUG 00:00:06] ClientTest.cpp:391: starting reset(__null)
[DEBUG 00:00:06] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:06] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:06] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:06] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:06] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:07] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:07] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:07] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:07] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:07] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:07] ClientTest.cpp:391: ending reset(__null)
[DEBUG 00:00:07] ClientTest.cpp:2488: ending deleteItem(createSourceA, child)
[DEBUG 00:00:07] ClientTest.cpp:2490: starting copy.reset(createSourceB())
[DEBUG 00:00:07] instantiating testing source file_event in config target-config@client-test-file, with tracking name _1_B
[DEBUG 00:00:07] overriding testing source file_event properties with the ones from config file_1 = /data/runtests/work/testing-amd64/home/file/config/syncevolution/client-test-1/peers/file_1
[DEBUG 00:00:07]    sync = disabled (set)
[DEBUG 00:00:07]    uri = cal2 (set)
[DEBUG 00:00:07]    backend = file (set)
[DEBUG 00:00:07]    syncFormat =  (default)
[DEBUG 00:00:07]    forceSyncFormat = 0 (default)
[DEBUG 00:00:07]    database = Test_file_event_1 (set)
[DEBUG 00:00:07]    databaseFormat =  (default)
[DEBUG 00:00:07]    databaseUser =  (default)
[DEBUG 00:00:07]    databasePassword =  (default)
[DEBUG 00:00:07] ClientTest.cpp:424: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:07] ClientTest.cpp:424: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:07] ClientTest.cpp:425: starting CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:07] ClientTest.cpp:425: ending CPPUNIT_ASSERT(!m_active)
[DEBUG 00:00:07] ClientTest.cpp:431: starting get()->open()
[DEBUG 00:00:07] ClientTest.cpp:431: ending get()->open()
[DEBUG 00:00:07] file_event: using full item scan to detect changes
[DEBUG 00:00:07] ClientTest.cpp:2490: ending copy.reset(createSourceB())
[DEBUG 00:00:07] ClientTest.cpp:2490: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2490: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2491: starting CPPUNIT_ASSERT_EQUAL((0),(countItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2491: ending CPPUNIT_ASSERT_EQUAL((0),(countItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2491: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2491: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2492: starting CPPUNIT_ASSERT_EQUAL((0),(countNewItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2492: ending CPPUNIT_ASSERT_EQUAL((0),(countNewItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2492: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2492: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2493: starting CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2493: ending CPPUNIT_ASSERT_EQUAL((0),(countUpdatedItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2493: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2493: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2494: starting CPPUNIT_ASSERT_EQUAL((2),(countDeletedItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2494: ending CPPUNIT_ASSERT_EQUAL((2),(countDeletedItems(copy.get())))
[DEBUG 00:00:07] ClientTest.cpp:2494: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2494: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2496: starting CPPUNIT_ASSERT_EQUAL((1),(countEqual(listDeletedItems(copy.get()), parent)))
[DEBUG 00:00:07] ClientTest.cpp:2496: ending CPPUNIT_ASSERT_EQUAL((1),(countEqual(listDeletedItems(copy.get()), parent)))
[DEBUG 00:00:07] ClientTest.cpp:2496: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2496: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2497: starting CPPUNIT_ASSERT_EQUAL((1),(countEqual(listDeletedItems(copy.get()), child)))
[DEBUG 00:00:07] ClientTest.cpp:2497: ending CPPUNIT_ASSERT_EQUAL((1),(countEqual(listDeletedItems(copy.get()), child)))
[DEBUG 00:00:07] ClientTest.cpp:2497: starting CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2497: ending CPPUNIT_ASSERT((copy.get()))
[DEBUG 00:00:07] ClientTest.cpp:2499: starting copy.reset()
[DEBUG 00:00:07] ClientTest.cpp:454: starting CPPUNIT_ASSERT(get())
[DEBUG 00:00:07] ClientTest.cpp:454: ending CPPUNIT_ASSERT(get())
[DEBUG 00:00:07] ClientTest.cpp:455: starting CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:07] ClientTest.cpp:455: ending CPPUNIT_ASSERT(m_active)
[DEBUG 00:00:07] ClientTest.cpp:458: starting get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:07] ClientTest.cpp:458: ending get()->getOperations().m_endDataWrite.getPostSignal()(*get(), OPERATION_FINISHED, sysync::LOCERR_OK, true, &dummy)
[DEBUG 00:00:07] ClientTest.cpp:461: starting anchor = get()->endSync(true)
[DEBUG 00:00:07] ClientTest.cpp:461: ending anchor = get()->endSync(true)
[DEBUG 00:00:07] ClientTest.cpp:463: starting get()->close()
[DEBUG 00:00:07] ClientTest.cpp:463: ending get()->close()
[DEBUG 00:00:07] ClientTest.cpp:2499: ending copy.reset()
[DEBUG 00:00:07] ClientTest.cpp:391: starting reset(__null)
[DEBUG 00:00:07] ClientTest.cpp:391: ending reset(__null)
[DEBUG 00:00:07] *** ending Client::Source::file_event::LinkedItemsWithVALARM::testLinkedItemsInsertBothUpdateChild: okay ***