Synchronization problem

[former_member608627]

Hey experts

we have a synchronization problem, it takes 17 hours and we do not know exactly where the problem is, I think there is a loop or something like that, how can I find the source of the problem, the log is understood

thank you

19.02.18 18:05:27:752 WARN Other cron job 'sync AMC_ProductCatalogCronJob' (pk:8800754106869) is still in UNKNOWN state. Waiting '867' milliseconds for start 19.02.18 18:05:28:637 WARN Session user is not admin but Master_Catalog_Employee[8796094464004] - due to possible restrictions synchronization may not cover all items 19.02.18 18:05:28:783 INFO Starting configureFullVersionSync ... 19.02.18 18:05:30:116 INFO Sync 'sync AMC_ProductCatalog:Staged->Online' (pk:8796551807476) configured 9967 entries for job '00003FGQ' (pk:8801336263157) schedule medias: 1 19.02.18 18:05:30:117 INFO Finished configureFullVersionSync in 1334ms 19.02.18 18:05:30:117 INFO Starting synchronization ... 19.02.18 19:01:32:082 INFO 1. pass, 9965 (+5081) of 9967 items processed (99 %), 145,81 items/sec, 3079 (+3079, deadlocks:829) items dumped. 19.02.19 05:38:30:158 INFO 2. pass, 3078 (+164) of 3079 items processed (99 %), 4,95 items/sec, 14305 (+14305, deadlocks:45) items dumped. 19.02.19 05:38:30:638 INFO comparing last dumps (3079/8932726505502 vs 14305/8933336121374) - this might take some time... 19.02.19 05:38:30:639 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:47:20:971 INFO 3. pass, 14304 (+3636) of 14305 items processed (99 %), 136,07 items/sec, 14715 (+14715, deadlocks:2667) items dumped. 19.02.19 10:47:21:103 INFO comparing last dumps (14305/8933336121374 vs 14715/8933468799006) - this might take some time... 19.02.19 10:47:21:108 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:49:03:083 INFO 4. pass, 14573 (+7683) of 14715 items processed (99 %), 182,49 items/sec, 8492 (+8492, deadlocks:312) items dumped. 19.02.19 10:49:03:206 INFO comparing last dumps (14715/8933468799006 vs 8492/8933468962846) - this might take some time... 19.02.19 10:49:03:208 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:50:07:821 INFO 5. pass, 8418 (+519) of 8492 items processed (99 %), 109,61 items/sec, 7050 (+7050, deadlocks:798) items dumped. 19.02.19 10:50:08:002 INFO comparing last dumps (8492/8933468962846 vs 7050/8933469126686) - this might take some time... 19.02.19 10:50:08:006 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:51:24:331 INFO 6. pass, 7016 (+40) of 7050 items processed (99 %), 14,79 items/sec, 3358 (+3358, deadlocks:229) items dumped. 19.02.19 10:51:24:443 INFO comparing last dumps (7050/8933469126686 vs 3358/8933469356062) - this might take some time... 19.02.19 10:51:24:469 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:53:58:194 INFO 7. pass, 3349 (+5) of 3358 items processed (99 %), 44,25 items/sec, 2975 (+2975, deadlocks:144) items dumped. 19.02.19 10:53:58:333 INFO comparing last dumps (3358/8933469356062 vs 2975/8933469585438) - this might take some time... 19.02.19 10:53:58:363 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:54:47:659 INFO 8. pass, 2972 (+2981) of 2975 items processed (99 %), 60,26 items/sec, 2788 (+2788, deadlocks:43) items dumped. 19.02.19 10:54:47:771 INFO comparing last dumps (2975/8933469585438 vs 2788/8933469749278) - this might take some time... 19.02.19 10:54:47:796 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:55:22:910 INFO 9. pass, 2787 (+2790) of 2788 items processed (99 %), 79,15 items/sec, 2737 (+2737, deadlocks:9) items dumped. 19.02.19 10:55:23:027 INFO comparing last dumps (2788/8933469749278 vs 2737/8933469847582) - this might take some time... 19.02.19 10:55:23:106 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:56:18:309 INFO 10. pass, 2736 (+2737) of 2737 items processed (99 %), 49,40 items/sec, 2727 (+2727, deadlocks:8) items dumped. 19.02.19 10:56:18:444 INFO comparing last dumps (2737/8933469847582 vs 2727/8933470011422) - this might take some time... 19.02.19 10:56:18:704 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:57:13:230 INFO 11. pass, 2726 (+2727) of 2727 items processed (99 %), 49,65 items/sec, 2714 (+2714, deadlocks:4) items dumped. 19.02.19 10:57:13:424 INFO comparing last dumps (2727/8933470011422 vs 2714/8933470175262) - this might take some time... 19.02.19 10:57:13:429 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:58:20:714 INFO 12. pass, 2713 (+246) of 2714 items processed (99 %), 33,43 items/sec, 2705 (+2705, deadlocks:9) items dumped. 19.02.19 10:58:20:944 INFO comparing last dumps (2714/8933470175262 vs 2705/8933470339102) - this might take some time... 19.02.19 10:58:21:038 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 10:59:34:052 INFO 13. pass, 2704 (+539) of 2705 items processed (99 %), 40,73 items/sec, 2694 (+2694, deadlocks:4) items dumped. 19.02.19 10:59:34:137 INFO comparing last dumps (2705/8933470339102 vs 2694/8933470568478) - this might take some time... 19.02.19 10:59:34:349 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 11:00:47:943 INFO 14. pass, 2693 (+521) of 2694 items processed (99 %), 37,85 items/sec, 2688 (+2688, deadlocks:3) items dumped. 19.02.19 11:00:48:118 INFO comparing last dumps (2694/8933470568478 vs 2688/8933470732318) - this might take some time... 19.02.19 11:00:48:394 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 11:02:18:081 INFO 15. pass, 2687 (+1055) of 2688 items processed (99 %), 34,87 items/sec, 2685 (+2685, deadlocks:3) items dumped. 19.02.19 11:02:18:655 INFO comparing last dumps (2688/8933470732318 vs 2685/8933470896158) - this might take some time... 19.02.19 11:02:18:703 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 11:04:29:256 INFO 16. pass, 2684 (+213) of 2685 items processed (99 %), 19,21 items/sec, 2681 (+2681, deadlocks:2) items dumped. 19.02.19 11:04:29:383 INFO comparing last dumps (2685/8933470896158 vs 2681/8933471125534) - this might take some time... 19.02.19 11:04:29:732 INFO Deadlock victim found in last dump. This will cause next round of synchronization. 19.02.19 11:06:29:946 INFO 17. pass, 2680 (+0) of 2681 items processed (99 %), 0,00 items/sec, 2678 (+2678, deadlocks:0) items dumped. 19.02.19 11:06:30:096 INFO comparing last dumps (2681/8933471125534 vs 2678/8933471420446) - this might take some time... 19.02.19 11:06:31:771 INFO done comparing last dumps - dumps are equal 19.02.19 11:06:31:946 ERROR sync ended with 2678 unfinished items - see last sync media for details 19.02.19 11:06:31:951 ERROR Finished synchronization in 0d 17h:01m:01s:834ms. There were errors during the synchronization!

---

cronjob runing

---

00003ETO sync AMC_ProductCatalog:Staged->Online (98%) [+++++++++++++++++++++++++++++++++-] elapsed: 3704s, average: 52s, 3652s slower than usual scheduled items: 206711, processed items: 201555, speed 194,00 items/s, dumped items: 208399