Scheduled deduplication job stops at saving_sharing phase
- Views:
- 432
- Visibility:
- Public
- Votes:
- 0
- Category:
- fas-systems
- Specialty:
- core
- Last Updated:
- 4/30/2024, 8:53:13 PM
Applies to
- ONTAP 9.3
- ONTAP 9.4
Issue
- Scheduled deduplication job stops at
saving_sharing
phase. - It finally causes change log full.
Example:
SIS -STATUS-L.xml
Checkpoint Stage: Saving_sharing
SIS log
Fri Nov 27 00:00:00 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 0] Info (sis start schedule)
Fri Nov 27 00:00:00 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402800] Begin (schedule)
Fri Nov 27 00:00:00 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402800] Sort (44048338 fp entries)
Fri Nov 27 00:01:51 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402800] Dedup Pass1 (1777260 dup entries)
Fri Nov 27 00:01:55 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402800] Dedup Pass2 (366008 dup entries)
Fri Nov 27 00:01:55 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402800] Sharing (0 return status)
Fri Nov 27 00:02:19 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402939] Begin (sis auto check)
Fri Nov 27 00:02:19 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402939] Verify
Fri Nov 27 00:04:31 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402939] Merge (39729004 stale entries)
Fri Nov 27 00:05:21 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402939] Sis Verify Phase End
Fri Nov 27 00:05:21 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402939] Stats (blks gathered 0,finger prints sorted 135854173,dups found 1777260,new dups found 366008,blks deduped 1845128,finger prints checked 134906749,finger prints deleted 39729004)
Fri Nov 27 00:05:21 2020 [Vserver UUID: de5d877b-eb36-xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606402939] End (176193352 KB)
Sat Nov 28 00:00:00 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 0] Info (sis start schedule)
Sat Nov 28 00:00:00 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606489200] Begin (schedule)
Sat Nov 28 00:00:00 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606489200] Sort (120963811 fp entries)
Sat Nov 28 00:03:41 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606489200] Dedup Pass1 (10670398 dup entries)
Sat Nov 28 00:03:58 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606489200] Dedup Pass2 (14344642 dup entries)
Sat Nov 28 00:04:19 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 1606489200] Sharing (0 return status)
<<< It stops hereSun Nov 29 00:00:00 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 0] Info (sis start schedule)
Mon Nov 30 00:00:00 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 0] Info (sis start schedule)
Tue Dec 1 00:00:00 2020 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 0] Info (sis start schedule)
...
Wed Jul 14 00:00:00 2021 [Vserver UUID: de5d877b-eb36- xxxx-xxxx-xxxxxxxx] /vol/vol1 [sid: 0] Info (sis start schedule)
EMS log
[?] Wed Jul 14 10:48:00 [controller-01: dense_split_worker: sis.changelog.full:error]: SIS change logging metafile for volume vol1@vserver:de5d877b-eb36-xxxx-xxxx-xxxxxxxx is full.