Exchange 2007 GRt backup failed
1:51:42.066 AM: [9920.6916] <4> ov_log::OVLoop: INF - Cycled log file
1:51:42.066 AM: [9920.6916] <4> ov_log::OVLoop: Timestamp
1:51:42.066 AM: [9920.6916] <4> tar_backup::backup_done_state: INF - number of file directives not found: 0
1:51:42.066 AM: [9920.6916] <4> tar_backup::backup_done_state: INF - number of file directives found: 1
1:51:42.066 AM: [9920.5040] <4> tar_base::keepaliveThread: INF - keepalive thread terminating (reason: WAIT_OBJECT_0)
1:51:42.066 AM: [9920.6916] <4> tar_base::stopKeepaliveThread: INF - keepalive thread has exited. (reason: WAIT_OBJECT_0)
1:51:42.082 AM: [9920.6916] <4> send_msg_to_monitor: INF - in send_msg_to_monitor()...
1:51:42.082 AM: [9920.6916] <2> tar_base::V_vTarMsgW: INF - EXIT STATUS 1: the requested operation was partially successful
1:51:53.113 AM: [9920.6916] <2> tar_base::V_vTarMsgW: WRN - Abnormal backup status, Exchange Transaction Logs were not truncated
1:51:53.113 AM: [9920.6916] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
1:51:53.191 AM: [9920.6916] <4> OVStopCmd: INF - EXIT - status = 0
1:51:53.191 AM: [9920.6916] <2> tar_base::V_Close: closing...
1:51:53.191 AM: [9920.6916] <4> dos_backup::tfs_reset: INF - Snapshot deletion start
1:51:53.441 AM: [9920.6916] <2> ov_log::V_GlobalLog: INF - BEDS_Term(): enter - InitFlags:0x00000001
1:52:09.097 AM: [9920.6916] <4> OVShutdown: INF - Finished process
1:52:09.097 AM: [9920.6916] <4> WinMain: INF - Exiting C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe
1:52:11.097 AM: [9920.6916] <4> ov_log::OVClose: INF - Closing log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\061011.LOG
12:05:02.580 PM: [10692.9172] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\061011.LOG
12:05:02.580 PM: [10692.9172] <4> ov_log::OVInit: GENERAL Log Level: 0
12:05:02.580 PM: [10692.9172] <4> ov_log::OVInit: TCP Log Level: 0
12:05:02.580 PM: [10692.9172] <4> ov_log::OVInit: INF - the log mutex: 580
BPBKAR NetBackup Backup/Archive 7.1GA [Feb 3 2011]
Copyright © 1993 - 2011 Symantec Corporation, All Rights Reserved.
All Rights Reserved.
12:05:02.611 PM: [10692.9172] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
12:05:02.611 PM: [10692.9172] <2> WinMain: DAT - lpCmdLine = '-r 86400 -ru root -dt 0 -to 0 -clnt dalaran -class Exchange_Bakambalaj -sched Full_Daily -st FULL -bpstart_to 300 -bpend_to 300 -read_to 3600 -ost_shmcd -blks_per_buffer 512 -pdi -granular_backup -use_otm -fso -b dalaran_1307696657 -kl 28 -ct 16 -use_ofb '
12:05:02.611 PM: [10692.9172] <2> date_debug: DAT - timezone: GTB Standard Time, offset=-7200, dst: GTB Daylight Time
12:05:02.611 PM: [10692.9172] <2> date_debug: DAT - current time: 1307696702, 6/10/2011 12:05:02 PM
12:05:02.611 PM: [10692.9172] <2> date_debug: DAT - 01/01/94 UCT: 757382400, 1/1/1994 3:00:00 AM
12:05:02.611 PM: [10692.9172] <2> date_debug: DAT - 07/01/94 UCT: 773020800, 7/1/1994 3:00:00 AM
12:05:02.611 PM: [10692.9172] <2> WinMain: DAT - standard input handle = 416
12:05:02.611 PM: [10692.9172] <2> WinMain: DAT - standard output handle = 768
12:05:02.611 PM: [10692.9172] <2> WinMain: DAT - standard error handle = 700
12:05:04.064 PM: [10692.9172] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff
12:05:04.064 PM: [10692.9172] <4> tar_backup::V_SetupJobData: INF - dwJob: ffffffff
12:05:04.689 PM: [10692.9172] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0
12:05:04.689 PM: [10692.9172] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0
12:05:04.689 PM: [10692.9172] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0
12:05:04.689 PM: [10692.9172] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0
12:05:04.689 PM: [10692.9172] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0
12:05:04.689 PM: [10692.9172] <4> dos_backup::V_PreProcessing: INF - user name: root
12:05:04.689 PM: [10692.9172] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup
12:05:04.705 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: D:
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E:
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: F:
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: NFS Network
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: VMware Shared Folders
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\DALARAN\Microsoft Exchange Mailboxes
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\DALARAN\Microsoft Exchange Public Folders
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: DALARAN\SCANMAIL
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\DALARAN\Microsoft Information Store
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\BAKAMBALAJ
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\EGE
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\First Storage Group
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\GRAVURE
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\HOLDING
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\POLIBAK
12:05:34.595 PM: [10692.9172] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\Second Storage Group
12:05:35.220 PM: [10692.9172] <2> tar_base::V_vTarMsgW: INF - BACKUP START 10692
12:05:35.439 PM: [10692.9172] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received
12:05:35.439 PM: [10692.9172] <2> tar_base::V_vTarMsgW: INF - CONTINUE BACKUP message received
12:05:35.658 PM: [10692.9172] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = Microsoft Information Store:\BAKAMBALAJ
12:05:35.658 PM: [10692.9172] <2> tar_backup::setupNBFSD_Credentials: INF - Processing nbfsd credentials and port number
12:05:37.798 PM: [10692.7864] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds
12:05:39.126 PM: [10692.9172] <2> tar_backup_vxbsa::add: INF - called with 'Microsoft Information Store:\BAKAMBALAJ'
12:05:39.126 PM: [10692.9172] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Microsoft Information Store:\BAKAMBALAJ' --> 10020020
12:05:39.126 PM: [10692.9172] <4> dos_backup::V_Initialize: INF - Exchange Backup - Disabling Open File Backups, Archive Bit processing, TIR, Job Estimating and Excludes.
12:05:41.173 PM: [10692.9172] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp'
12:05:41.173 PM: [10692.9172] <2> beds_ese_access::V_OpenForRead(): WRN - no BEDS handle, treating object as a directory
12:05:41.220 PM: [10692.9172] <2> raiPdiAttach(): INF - creating pdi resoure for '\\DALARAN\Microsoft Information Store\BAKAMBALAJ'
12:05:41.220 PM: [10692.9172] <2> raiPdiAttach(): INF - pdi path: 'C:\Program Files\Veritas\NetBackup\temp\dalaran_1307696657\BAKAMBALAJ\'
12:05:41.251 PM: [10692.9172] <2> beds_pdi::startNbfsd(): INF - mounting nbfs with credentials
12:05:41.251 PM: [10692.9172] <2> tar_base::V_vTarMsgW: JBD - INF - waiting for mount mutex
12:05:43.689 PM: [10692.9172] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
12:05:43.704 PM: [10692.9172] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\BAKAMBALAJ\BAKAMBALAJ_MDB (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
12:05:43.751 PM: [10692.9172] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
12:05:43.751 PM: [10692.9172] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\BAKAMBALAJ\Log files (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
12:05:43.954 PM: [10692.9172] <2> beds_pdi::mutex_wait(): INF - waiting for nbfs delta mutex
12:05:43.954 PM: [10692.9172] <2> beds_pdi::mutex_wait(): INF - obtained nbfs delta mutex
12:05:43.954 PM: [10692.9172] <2> beds_pdi::mutex_wait(): INF - released nbfs delta mutex
12:05:43.954 PM: [10692.9172] <2> beds_pdi::mutex_wait(): INF - waiting for nbfs mutex
1:20:37.769 PM: [10692.7864] <16> dtcp_write: TCP - failure: send socket (700) (TCP 10054: Connection reset by peer)
1:20:37.769 PM: [10692.7864] <16> dtcp_write: TCP - failure: attempted to send 1 bytes
1:20:37.769 PM: [10692.7864] <16> tar_base::keepaliveThread: INF - keepalive thread abnormal exit :14
1:29:52.703 PM: [3676.4904] <4> ov_log::OVInit: INF - Starting log file: C:\Program Files\Veritas\NetBackup\logs\BPBKAR\061011.LOG
1:29:52.703 PM: [3676.4904] <4> ov_log::OVInit: GENERAL Log Level: 0
1:29:52.703 PM: [3676.4904] <4> ov_log::OVInit: TCP Log Level: 0
1:29:52.703 PM: [3676.4904] <4> ov_log::OVInit: INF - the log mutex: 576
BPBKAR NetBackup Backup/Archive 7.1GA [Feb 3 2011]
Copyright © 1993 - 2011 Symantec Corporation, All Rights Reserved.
All Rights Reserved.
1:29:52.719 PM: [3676.4904] <2> WinMain: DAT - _pgmptr = 'C:\Program Files\Veritas\NetBackup\bin\bpbkar32.exe'
1:29:52.719 PM: [3676.4904] <2> WinMain: DAT - lpCmdLine = '-r 86400 -ru root -dt 0 -to 0 -clnt dalaran -class Exchange_Bakambalaj -sched Full_Daily -st FULL -bpstart_to 300 -bpend_to 300 -read_to 3600 -ost_shmcd -blks_per_buffer 512 -pdi -granular_backup -use_otm -fso -b dalaran_1307701773 -kl 28 -ct 16 -use_ofb '
1:29:52.719 PM: [3676.4904] <2> date_debug: DAT - timezone: GTB Standard Time, offset=-7200, dst: GTB Daylight Time
1:29:52.719 PM: [3676.4904] <2> date_debug: DAT - current time: 1307701792, 6/10/2011 1:29:52 PM
1:29:52.719 PM: [3676.4904] <2> date_debug: DAT - 01/01/94 UCT: 757382400, 1/1/1994 3:00:00 AM
1:29:52.719 PM: [3676.4904] <2> date_debug: DAT - 07/01/94 UCT: 773020800, 7/1/1994 3:00:00 AM
1:29:52.719 PM: [3676.4904] <2> WinMain: DAT - standard input handle = 444
1:29:52.719 PM: [3676.4904] <2> WinMain: DAT - standard output handle = 768
1:29:52.719 PM: [3676.4904] <2> WinMain: DAT - standard error handle = 692
1:29:52.797 PM: [3676.4904] <4> tar_backup::V_SetupJobData: INF - dwJobData: ffffffff
1:29:52.797 PM: [3676.4904] <4> tar_backup::V_SetupJobData: INF - dwJob: ffffffff
1:29:53.235 PM: [3676.4904] <4> dos_backup::V_PreProcessing: INF - backup privileges enabled, previous = 0
1:29:53.235 PM: [3676.4904] <4> dos_backup::V_PreProcessing: INF - restore privileges enabled, previous = 0
1:29:53.235 PM: [3676.4904] <4> dos_backup::V_PreProcessing: INF - security privileges enabled, previous = 0
1:29:53.235 PM: [3676.4904] <4> dos_backup::V_PreProcessing: INF - tcb privileges enabled, previous = 0
1:29:53.235 PM: [3676.4904] <4> dos_backup::V_PreProcessing: INF - create token privileges enabled, previous = 0
1:29:53.235 PM: [3676.4904] <4> dos_backup::V_PreProcessing: INF - user name: root
1:29:53.235 PM: [3676.4904] <4> dos_backup::V_PreProcessing: INF - no access token: scheduled backup
1:29:53.235 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - BEDS_Init() Enter InitFlags:0x0
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: C:
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: D:
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: E:
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: F:
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Terminal Services
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Microsoft Windows Network
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: NFS Network
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: VMware Shared Folders
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Web Client Network
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\DALARAN\Microsoft Exchange Mailboxes
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\DALARAN\Microsoft Exchange Public Folders
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: DALARAN\SCANMAIL
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Shadow?Copy?Components
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: System?State
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: Active Directory Application Mode
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpDleInfo() DLE Device Name: \\DALARAN\Microsoft Information Store
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\BAKAMBALAJ
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\EGE
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\First Storage Group
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\GRAVURE
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\HOLDING
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\POLIBAK
1:30:05.360 PM: [3676.4904] <2> ov_log::V_GlobalLog: INF - DumpChildDleInfo() Child DLE Device Name: \\DALARAN\Microsoft Information Store\Second Storage Group
1:30:06.031 PM: [3676.4904] <2> tar_base::V_vTarMsgW: INF - BACKUP START 3676
1:30:06.235 PM: [3676.4904] <2> tar_backup::V_SetupProcessContinue: TAR - CONTINUE BACKUP received
1:30:06.235 PM: [3676.4904] <2> tar_base::V_vTarMsgW: INF - CONTINUE BACKUP message received
1:30:06.375 PM: [3676.4904] <2> tar_backup_tfi::setupFileDirectives: TAR - backup filename = Microsoft Information Store:\BAKAMBALAJ
1:30:06.375 PM: [3676.4904] <2> tar_backup::setupNBFSD_Credentials: INF - Processing nbfsd credentials and port number
1:30:09.078 PM: [3676.9132] <4> tar_base::keepaliveThread: INF - keepalive thread is active with an interval of 60 seconds
1:30:10.188 PM: [3676.4904] <2> tar_backup_vxbsa::add: INF - called with 'Microsoft Information Store:\BAKAMBALAJ'
1:30:10.188 PM: [3676.4904] <4> dos_backup::V_VerifyFileList: INF - UBS Local Type for 'Microsoft Information Store:\BAKAMBALAJ' --> 10020020
1:30:10.188 PM: [3676.4904] <4> dos_backup::V_Initialize: INF - Exchange Backup - Disabling Open File Backups, Archive Bit processing, TIR, Job Estimating and Excludes.
1:30:11.203 PM: [3676.4904] <4> backup_create: INF - NetBackup Temp Directory: 'C:\Program Files\Veritas\\NetBackup\Temp'
1:30:11.219 PM: [3676.4904] <2> beds_ese_access::V_OpenForRead(): WRN - no BEDS handle, treating object as a directory
1:30:11.266 PM: [3676.4904] <2> raiPdiAttach(): INF - creating pdi resoure for '\\DALARAN\Microsoft Information Store\BAKAMBALAJ'
1:30:11.266 PM: [3676.4904] <2> raiPdiAttach(): INF - pdi path: 'C:\Program Files\Veritas\NetBackup\temp\dalaran_1307701773\BAKAMBALAJ\'
1:30:11.297 PM: [3676.4904] <2> beds_pdi::startNbfsd(): INF - mounting nbfs with credentials
1:30:11.297 PM: [3676.4904] <2> tar_base::V_vTarMsgW: JBD - INF - waiting for mount mutex
1:30:13.110 PM: [3676.4904] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
1:30:13.110 PM: [3676.4904] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\BAKAMBALAJ\BAKAMBALAJ_MDB (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
1:30:13.172 PM: [3676.4904] <2> beds_ese_access::V_Read(): ERR - FS_ReadObj() Failed! (0xE000FEA9:The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
1:30:13.172 PM: [3676.4904] <2> tar_base::V_vTarMsgW: ERR - failure reading file: Microsoft Information Store:\BAKAMBALAJ\Log files (BEDS 0xE000FEA9: The Backup Exec data store encountered a problem during the operation. See the job log for details.
)
1:30:13.219 PM: [3676.4904] <2> beds_pdi::mutex_wait(): INF - waiting for nbfs delta mutex
1:30:13.219 PM: [3676.4904] <2> beds_pdi::mutex_wait(): INF - obtained nbfs delta mutex
1:30:13.219 PM: [3676.4904] <2> beds_pdi::mutex_wait(): INF - released nbfs delta mutex
1:30:13.219 PM: [3676.4904] <2> beds_pdi::mutex_wait(): INF - waiting for nbfs mutex