08:38:35.927 [5384.796] <2> bptm: INITIATING (VERBOSE = 0): -rptdrv -jobid -1393107234 -jm 
08:38:35.927 [5384.796] <2> drivename_open: Called with Create 0, file HP.ULTRIUM3-SCSI.006
08:38:35.927 [5384.796] <2> drivename_checklock: Called
08:38:35.927 [5384.796] <2> report_drives: DRIVE = HP.ULTRIUM3-SCSI.006 LOCK = FALSE CURTIME = 1393573115
08:38:35.927 [5384.796] <2> drivename_close: Called for file HP.ULTRIUM3-SCSI.006
08:38:35.927 [5384.796] <2> report_drives: MODE = 2
08:38:35.927 [5384.796] <2> report_drives: TIME = 1380779946
08:38:35.927 [5384.796] <2> report_drives: MASTER = adm-master01
08:38:35.927 [5384.796] <2> report_drives: SR_KEY = 551550983 2000465
08:38:35.927 [5384.796] <2> report_drives: PATH = {3,0,0,0}
08:38:35.927 [5384.796] <2> report_drives: REQID = -1380722903
08:38:35.927 [5384.796] <2> report_drives: ALOCID = 111350286
08:38:35.927 [5384.796] <2> report_drives: RBID = {C5C42F0A-1F7A-43C3-BFD3-8BA29A763928}
08:38:35.927 [5384.796] <2> report_drives: PID = 7832
08:38:35.927 [5384.796] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_HP.ULTRIUM3-SCSI.006
08:38:35.927 [5384.796] <2> drivename_open: Called with Create 0, file IBM.ULT3580-TD5.Drive2
08:38:35.927 [5384.796] <2> drivename_checklock: Called
08:38:35.927 [5384.796] <2> report_drives: DRIVE = IBM.ULT3580-TD5.Drive2 LOCK = FALSE CURTIME = 1393573115
08:38:35.927 [5384.796] <2> drivename_close: Called for file IBM.ULT3580-TD5.Drive2
08:38:35.927 [5384.796] <2> report_drives: MODE = 2
08:38:35.927 [5384.796] <2> report_drives: TIME = 1393480716
08:38:35.927 [5384.796] <2> report_drives: MASTER = adm-master01
08:38:35.927 [5384.796] <2> report_drives: SR_KEY = 3905945607 2000495
08:38:35.927 [5384.796] <2> report_drives: PATH = {3,0,7,0}
08:38:35.927 [5384.796] <2> report_drives: REQID = -1393099837
08:38:35.927 [5384.796] <2> report_drives: ALOCID = 117960333
08:38:35.927 [5384.796] <2> report_drives: RBID = {B062D34D-CC24-433D-BEA3-AD9CF91C2B5E}
08:38:35.927 [5384.796] <2> report_drives: PID = 7640
08:38:35.927 [5384.796] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_IBM.ULT3580-TD5.Drive2
08:38:35.927 [5384.796] <2> main: Sending [EXIT STATUS 0] to NBJM
08:38:35.927 [5384.796] <2> bptm: EXITING with status 0 <----------
08:44:26.819 [4468.1884] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
08:44:26.834 [4468.1884] <2> vnet_pbxConnect: pbxConnectEx Succeeded
08:44:26.834 [4468.1884] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.49975 TO 146.253.66.129.1556 fd = 1480
08:44:26.834 [4468.1884] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
08:44:26.881 [4468.1884] <2> db_end: Need to collect reply
08:44:26.881 [4468.1884] <4> report_throughput: VBRT 1 4468 1 1 PureDiskVolume @aaab3 0 1 0 4001280  4001280 (bptm.c.25633)
08:44:26.881 [4468.1884] <2> write_data: Total Kbytes transferred 194813184
08:45:21.700 [4468.1884] <2> send_MDS_msg: KBYTES_WRITTEN 0 {D8192518-30ED-4BE8-ABFD-BEFEC80887A6} 117995792 1 195004160 427228
08:45:21.700 [4468.1884] <2> EndpointSelector_R2::updateConfMembers: epsr2: bp.conf LastUpd=1393495990 bp.conf LastLook=1393534830(Endpoint_Selector.cpp:403)
08:45:21.700 [4468.1884] <2> EndpointSelectorFactory::get_selector: epsr2: got 7.x EPS(Endpoint_Selector.cpp:2019)
08:45:21.700 [4468.1884] <2> EndpointSelector_R2::select_endpoint: epsr2: EPS Honoring Server List(Endpoint_Selector.cpp:530)
08:45:21.700 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Evaluating 3 endpoints(Endpoint_Selector.cpp:631)
08:45:21.700 [4468.1884] <2> ConnectList::search: host 146.253.66.129 found GOOD(ConnectList.cpp:91)
08:45:21.700 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Reusing endpoint, target: 146.253.66.129, source: ANY(Endpoint_Selector.cpp:688)
08:45:21.700 [4468.1884] <2> VxssContext::updateOnFailure: epsr2: updateOnFailure?=0 useVxss=2(Endpoint_Selector.cpp:243)
08:45:21.700 [4468.1884] <2> EndpointSelector_R2::performCallUsingEndpoint: epsr2: insecure invocation->perform_call(...) to host 146.253.66.129 SUCCESS(Endpoint_Selector.cpp:1198)
08:45:21.700 [4468.1884] <2> ConnectList::update: updated host 146.253.66.129 as GOOD, used 0 of 3 retries(ConnectList.cpp:180)
08:45:21.700 [4468.1884] <2> JobInst::sendIrmMsg: returning
08:48:36.138 [7240.1036] <2> bptm: INITIATING (VERBOSE = 0): -rptdrv -jobid -1393107253 -jm 
08:48:36.138 [7240.1036] <2> drivename_open: Called with Create 0, file HP.ULTRIUM3-SCSI.006
08:48:36.138 [7240.1036] <2> drivename_checklock: Called
08:48:36.138 [7240.1036] <2> report_drives: DRIVE = HP.ULTRIUM3-SCSI.006 LOCK = FALSE CURTIME = 1393573716
08:48:36.138 [7240.1036] <2> drivename_close: Called for file HP.ULTRIUM3-SCSI.006
08:48:36.138 [7240.1036] <2> report_drives: MODE = 2
08:48:36.138 [7240.1036] <2> report_drives: TIME = 1380779946
08:48:36.138 [7240.1036] <2> report_drives: MASTER = adm-master01
08:48:36.138 [7240.1036] <2> report_drives: SR_KEY = 551550983 2000465
08:48:36.138 [7240.1036] <2> report_drives: PATH = {3,0,0,0}
08:48:36.138 [7240.1036] <2> report_drives: REQID = -1380722903
08:48:36.138 [7240.1036] <2> report_drives: ALOCID = 111350286
08:48:36.138 [7240.1036] <2> report_drives: RBID = {C5C42F0A-1F7A-43C3-BFD3-8BA29A763928}
08:48:36.138 [7240.1036] <2> report_drives: PID = 7832
08:48:36.138 [7240.1036] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_HP.ULTRIUM3-SCSI.006
08:48:36.138 [7240.1036] <2> drivename_open: Called with Create 0, file IBM.ULT3580-TD5.Drive2
08:48:36.138 [7240.1036] <2> drivename_checklock: Called
08:48:36.138 [7240.1036] <2> report_drives: DRIVE = IBM.ULT3580-TD5.Drive2 LOCK = FALSE CURTIME = 1393573716
08:48:36.138 [7240.1036] <2> drivename_close: Called for file IBM.ULT3580-TD5.Drive2
08:48:36.138 [7240.1036] <2> report_drives: MODE = 2
08:48:36.138 [7240.1036] <2> report_drives: TIME = 1393480716
08:48:36.138 [7240.1036] <2> report_drives: MASTER = adm-master01
08:48:36.138 [7240.1036] <2> report_drives: SR_KEY = 3905945607 2000495
08:48:36.138 [7240.1036] <2> report_drives: PATH = {3,0,7,0}
08:48:36.138 [7240.1036] <2> report_drives: REQID = -1393099837
08:48:36.138 [7240.1036] <2> report_drives: ALOCID = 117960333
08:48:36.138 [7240.1036] <2> report_drives: RBID = {B062D34D-CC24-433D-BEA3-AD9CF91C2B5E}
08:48:36.138 [7240.1036] <2> report_drives: PID = 7640
08:48:36.138 [7240.1036] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_IBM.ULT3580-TD5.Drive2
08:48:36.138 [7240.1036] <2> main: Sending [EXIT STATUS 0] to NBJM
08:48:36.138 [7240.1036] <2> bptm: EXITING with status 0 <----------
08:49:15.123 [4148.8084] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
08:49:15.138 [4148.8084] <2> vnet_pbxConnect: pbxConnectEx Succeeded
08:49:15.138 [4148.8084] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50079 TO 146.253.66.129.1556 fd = 1144
08:49:15.138 [4148.8084] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
08:49:15.170 [4148.8084] <2> db_end: Need to collect reply
08:49:15.170 [4148.8084] <4> report_throughput: VBRT 1 4148 1 1 PureDiskVolume @aaab3 0 1 0 2202112  2202112 (bptm.c.25633)
08:49:15.170 [4148.8084] <2> write_data: Total Kbytes transferred 28227072
08:58:36.053 [4856.5484] <2> bptm: INITIATING (VERBOSE = 0): -rptdrv -jobid -1393107271 -jm 
08:58:36.053 [4856.5484] <2> drivename_open: Called with Create 0, file HP.ULTRIUM3-SCSI.006
08:58:36.053 [4856.5484] <2> drivename_checklock: Called
08:58:36.053 [4856.5484] <2> report_drives: DRIVE = HP.ULTRIUM3-SCSI.006 LOCK = FALSE CURTIME = 1393574316
08:58:36.053 [4856.5484] <2> drivename_close: Called for file HP.ULTRIUM3-SCSI.006
08:58:36.053 [4856.5484] <2> report_drives: MODE = 2
08:58:36.053 [4856.5484] <2> report_drives: TIME = 1380779946
08:58:36.053 [4856.5484] <2> report_drives: MASTER = adm-master01
08:58:36.053 [4856.5484] <2> report_drives: SR_KEY = 551550983 2000465
08:58:36.053 [4856.5484] <2> report_drives: PATH = {3,0,0,0}
08:58:36.053 [4856.5484] <2> report_drives: REQID = -1380722903
08:58:36.053 [4856.5484] <2> report_drives: ALOCID = 111350286
08:58:36.053 [4856.5484] <2> report_drives: RBID = {C5C42F0A-1F7A-43C3-BFD3-8BA29A763928}
08:58:36.053 [4856.5484] <2> report_drives: PID = 7832
08:58:36.053 [4856.5484] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_HP.ULTRIUM3-SCSI.006
08:58:36.053 [4856.5484] <2> drivename_open: Called with Create 0, file IBM.ULT3580-TD5.Drive2
08:58:36.053 [4856.5484] <2> drivename_checklock: Called
08:58:36.053 [4856.5484] <2> report_drives: DRIVE = IBM.ULT3580-TD5.Drive2 LOCK = FALSE CURTIME = 1393574316
08:58:36.053 [4856.5484] <2> drivename_close: Called for file IBM.ULT3580-TD5.Drive2
08:58:36.053 [4856.5484] <2> report_drives: MODE = 2
08:58:36.053 [4856.5484] <2> report_drives: TIME = 1393480716
08:58:36.053 [4856.5484] <2> report_drives: MASTER = adm-master01
08:58:36.053 [4856.5484] <2> report_drives: SR_KEY = 3905945607 2000495
08:58:36.053 [4856.5484] <2> report_drives: PATH = {3,0,7,0}
08:58:36.053 [4856.5484] <2> report_drives: REQID = -1393099837
08:58:36.053 [4856.5484] <2> report_drives: ALOCID = 117960333
08:58:36.053 [4856.5484] <2> report_drives: RBID = {B062D34D-CC24-433D-BEA3-AD9CF91C2B5E}
08:58:36.053 [4856.5484] <2> report_drives: PID = 7640
08:58:36.053 [4856.5484] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_IBM.ULT3580-TD5.Drive2
08:58:36.053 [4856.5484] <2> main: Sending [EXIT STATUS 0] to NBJM
08:58:36.053 [4856.5484] <2> bptm: EXITING with status 0 <----------
09:00:31.431 [4468.1884] <2> send_MDS_msg: KBYTES_WRITTEN 0 {D8192518-30ED-4BE8-ABFD-BEFEC80887A6} 117995792 1 198004224 427228
09:00:31.431 [4468.1884] <2> EndpointSelector_R2::updateConfMembers: epsr2: bp.conf LastUpd=1393495990 bp.conf LastLook=1393534830(Endpoint_Selector.cpp:403)
09:00:31.431 [4468.1884] <2> EndpointSelectorFactory::get_selector: epsr2: got 7.x EPS(Endpoint_Selector.cpp:2019)
09:00:31.431 [4468.1884] <2> EndpointSelector_R2::select_endpoint: epsr2: EPS Honoring Server List(Endpoint_Selector.cpp:530)
09:00:31.431 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Evaluating 3 endpoints(Endpoint_Selector.cpp:631)
09:00:31.431 [4468.1884] <2> ConnectList::search: host 146.253.66.129 found GOOD(ConnectList.cpp:91)
09:00:31.431 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Reusing endpoint, target: 146.253.66.129, source: ANY(Endpoint_Selector.cpp:688)
09:00:31.431 [4468.1884] <2> VxssContext::updateOnFailure: epsr2: updateOnFailure?=0 useVxss=2(Endpoint_Selector.cpp:243)
09:00:31.431 [4468.1884] <2> EndpointSelector_R2::performCallUsingEndpoint: epsr2: insecure invocation->perform_call(...) to host 146.253.66.129 SUCCESS(Endpoint_Selector.cpp:1198)
09:00:31.431 [4468.1884] <2> ConnectList::update: updated host 146.253.66.129 as GOOD, used 0 of 3 retries(ConnectList.cpp:180)
09:00:31.431 [4468.1884] <2> JobInst::sendIrmMsg: returning
09:04:54.073 [4468.1884] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:04:54.089 [4468.1884] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:04:54.089 [4468.1884] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50341 TO 146.253.66.129.1556 fd = 1480
09:04:54.089 [4468.1884] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:04:54.120 [4468.1884] <2> db_end: Need to collect reply
09:04:54.120 [4468.1884] <4> report_throughput: VBRT 1 4468 1 1 PureDiskVolume @aaab3 0 1 0 5201664  5201664 (bptm.c.25633)
09:04:54.120 [4468.1884] <2> write_data: Total Kbytes transferred 200014848
09:07:39.854 [4468.1884] <2> send_MDS_msg: KBYTES_WRITTEN 0 {D8192518-30ED-4BE8-ABFD-BEFEC80887A6} 117995792 1 201004288 427228
09:07:39.854 [4468.1884] <2> EndpointSelector_R2::updateConfMembers: epsr2: bp.conf LastUpd=1393495990 bp.conf LastLook=1393534830(Endpoint_Selector.cpp:403)
09:07:39.854 [4468.1884] <2> EndpointSelectorFactory::get_selector: epsr2: got 7.x EPS(Endpoint_Selector.cpp:2019)
09:07:39.854 [4468.1884] <2> EndpointSelector_R2::select_endpoint: epsr2: EPS Honoring Server List(Endpoint_Selector.cpp:530)
09:07:39.854 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Evaluating 3 endpoints(Endpoint_Selector.cpp:631)
09:07:39.854 [4468.1884] <2> ConnectList::search: host 146.253.66.129 found GOOD(ConnectList.cpp:91)
09:07:39.854 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Reusing endpoint, target: 146.253.66.129, source: ANY(Endpoint_Selector.cpp:688)
09:07:39.854 [4468.1884] <2> VxssContext::updateOnFailure: epsr2: updateOnFailure?=0 useVxss=2(Endpoint_Selector.cpp:243)
09:07:39.854 [4468.1884] <2> EndpointSelector_R2::performCallUsingEndpoint: epsr2: insecure invocation->perform_call(...) to host 146.253.66.129 SUCCESS(Endpoint_Selector.cpp:1198)
09:07:39.854 [4468.1884] <2> ConnectList::update: updated host 146.253.66.129 as GOOD, used 0 of 3 retries(ConnectList.cpp:180)
09:07:39.854 [4468.1884] <2> JobInst::sendIrmMsg: returning
09:07:45.112 [4148.8084] <2> send_MDS_msg: KBYTES_WRITTEN 0 {86FE2AAC-D076-4858-A4B4-37DF07C1A432} 118018837 1 30000640 428737
09:07:45.112 [4148.8084] <2> EndpointSelector_R2::updateConfMembers: epsr2: bp.conf LastUpd=1393495990 bp.conf LastLook=1393555898(Endpoint_Selector.cpp:403)
09:07:45.112 [4148.8084] <2> EndpointSelectorFactory::get_selector: epsr2: got 7.x EPS(Endpoint_Selector.cpp:2019)
09:07:45.112 [4148.8084] <2> EndpointSelector_R2::select_endpoint: epsr2: EPS Honoring Server List(Endpoint_Selector.cpp:530)
09:07:45.112 [4148.8084] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Evaluating 3 endpoints(Endpoint_Selector.cpp:631)
09:07:45.112 [4148.8084] <2> ConnectList::search: host 146.253.66.129 found GOOD(ConnectList.cpp:91)
09:07:45.112 [4148.8084] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Reusing endpoint, target: 146.253.66.129, source: ANY(Endpoint_Selector.cpp:688)
09:07:45.112 [4148.8084] <2> VxssContext::updateOnFailure: epsr2: updateOnFailure?=0 useVxss=2(Endpoint_Selector.cpp:243)
09:07:45.112 [4148.8084] <2> EndpointSelector_R2::performCallUsingEndpoint: epsr2: insecure invocation->perform_call(...) to host 146.253.66.129 SUCCESS(Endpoint_Selector.cpp:1198)
09:07:45.112 [4148.8084] <2> ConnectList::update: updated host 146.253.66.129 as GOOD, used 0 of 3 retries(ConnectList.cpp:180)
09:07:45.112 [4148.8084] <2> JobInst::sendIrmMsg: returning
09:08:36.202 [5612.7244] <2> bptm: INITIATING (VERBOSE = 0): -rptdrv -jobid -1393107347 -jm 
09:08:36.202 [5612.7244] <2> drivename_open: Called with Create 0, file HP.ULTRIUM3-SCSI.006
09:08:36.202 [5612.7244] <2> drivename_checklock: Called
09:08:36.202 [5612.7244] <2> report_drives: DRIVE = HP.ULTRIUM3-SCSI.006 LOCK = FALSE CURTIME = 1393574916
09:08:36.202 [5612.7244] <2> drivename_close: Called for file HP.ULTRIUM3-SCSI.006
09:08:36.202 [5612.7244] <2> report_drives: MODE = 2
09:08:36.202 [5612.7244] <2> report_drives: TIME = 1380779946
09:08:36.202 [5612.7244] <2> report_drives: MASTER = adm-master01
09:08:36.202 [5612.7244] <2> report_drives: SR_KEY = 551550983 2000465
09:08:36.202 [5612.7244] <2> report_drives: PATH = {3,0,0,0}
09:08:36.202 [5612.7244] <2> report_drives: REQID = -1380722903
09:08:36.202 [5612.7244] <2> report_drives: ALOCID = 111350286
09:08:36.202 [5612.7244] <2> report_drives: RBID = {C5C42F0A-1F7A-43C3-BFD3-8BA29A763928}
09:08:36.202 [5612.7244] <2> report_drives: PID = 7832
09:08:36.202 [5612.7244] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_HP.ULTRIUM3-SCSI.006
09:08:36.202 [5612.7244] <2> drivename_open: Called with Create 0, file IBM.ULT3580-TD5.Drive2
09:08:36.202 [5612.7244] <2> drivename_checklock: Called
09:08:36.202 [5612.7244] <2> report_drives: DRIVE = IBM.ULT3580-TD5.Drive2 LOCK = FALSE CURTIME = 1393574916
09:08:36.202 [5612.7244] <2> drivename_close: Called for file IBM.ULT3580-TD5.Drive2
09:08:36.202 [5612.7244] <2> report_drives: MODE = 2
09:08:36.202 [5612.7244] <2> report_drives: TIME = 1393480716
09:08:36.202 [5612.7244] <2> report_drives: MASTER = adm-master01
09:08:36.202 [5612.7244] <2> report_drives: SR_KEY = 3905945607 2000495
09:08:36.202 [5612.7244] <2> report_drives: PATH = {3,0,7,0}
09:08:36.202 [5612.7244] <2> report_drives: REQID = -1393099837
09:08:36.202 [5612.7244] <2> report_drives: ALOCID = 117960333
09:08:36.202 [5612.7244] <2> report_drives: RBID = {B062D34D-CC24-433D-BEA3-AD9CF91C2B5E}
09:08:36.202 [5612.7244] <2> report_drives: PID = 7640
09:08:36.202 [5612.7244] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_IBM.ULT3580-TD5.Drive2
09:08:36.202 [5612.7244] <2> main: Sending [EXIT STATUS 0] to NBJM
09:08:36.202 [5612.7244] <2> bptm: EXITING with status 0 <----------
09:10:31.860 [4148.8084] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:10:31.923 [4148.8084] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:10:31.923 [4148.8084] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50400 TO 146.253.66.129.1556 fd = 1144
09:10:31.923 [4148.8084] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:10:31.970 [4148.8084] <2> db_end: Need to collect reply
09:10:31.970 [4148.8084] <4> report_throughput: VBRT 1 4148 1 1 PureDiskVolume @aaab3 0 1 0 2001920  2001920 (bptm.c.25633)
09:10:31.970 [4148.8084] <2> write_data: Total Kbytes transferred 30228992
09:18:36.007 [7012.8340] <2> bptm: INITIATING (VERBOSE = 0): -rptdrv -jobid -1393107413 -jm 
09:18:36.007 [7012.8340] <2> drivename_open: Called with Create 0, file HP.ULTRIUM3-SCSI.006
09:18:36.007 [7012.8340] <2> drivename_checklock: Called
09:18:36.007 [7012.8340] <2> report_drives: DRIVE = HP.ULTRIUM3-SCSI.006 LOCK = FALSE CURTIME = 1393575516
09:18:36.007 [7012.8340] <2> drivename_close: Called for file HP.ULTRIUM3-SCSI.006
09:18:36.007 [7012.8340] <2> report_drives: MODE = 2
09:18:36.007 [7012.8340] <2> report_drives: TIME = 1380779946
09:18:36.007 [7012.8340] <2> report_drives: MASTER = adm-master01
09:18:36.007 [7012.8340] <2> report_drives: SR_KEY = 551550983 2000465
09:18:36.007 [7012.8340] <2> report_drives: PATH = {3,0,0,0}
09:18:36.007 [7012.8340] <2> report_drives: REQID = -1380722903
09:18:36.007 [7012.8340] <2> report_drives: ALOCID = 111350286
09:18:36.007 [7012.8340] <2> report_drives: RBID = {C5C42F0A-1F7A-43C3-BFD3-8BA29A763928}
09:18:36.007 [7012.8340] <2> report_drives: PID = 7832
09:18:36.007 [7012.8340] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_HP.ULTRIUM3-SCSI.006
09:18:36.007 [7012.8340] <2> drivename_open: Called with Create 0, file IBM.ULT3580-TD5.Drive2
09:18:36.007 [7012.8340] <2> drivename_checklock: Called
09:18:36.007 [7012.8340] <2> report_drives: DRIVE = IBM.ULT3580-TD5.Drive2 LOCK = FALSE CURTIME = 1393575516
09:18:36.007 [7012.8340] <2> drivename_close: Called for file IBM.ULT3580-TD5.Drive2
09:18:36.007 [7012.8340] <2> report_drives: MODE = 2
09:18:36.007 [7012.8340] <2> report_drives: TIME = 1393480716
09:18:36.007 [7012.8340] <2> report_drives: MASTER = adm-master01
09:18:36.007 [7012.8340] <2> report_drives: SR_KEY = 3905945607 2000495
09:18:36.007 [7012.8340] <2> report_drives: PATH = {3,0,7,0}
09:18:36.007 [7012.8340] <2> report_drives: REQID = -1393099837
09:18:36.007 [7012.8340] <2> report_drives: ALOCID = 117960333
09:18:36.007 [7012.8340] <2> report_drives: RBID = {B062D34D-CC24-433D-BEA3-AD9CF91C2B5E}
09:18:36.007 [7012.8340] <2> report_drives: PID = 7640
09:18:36.007 [7012.8340] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_IBM.ULT3580-TD5.Drive2
09:18:36.007 [7012.8340] <2> main: Sending [EXIT STATUS 0] to NBJM
09:18:36.007 [7012.8340] <2> bptm: EXITING with status 0 <----------
09:22:05.703 [4468.1884] <2> send_MDS_msg: KBYTES_WRITTEN 0 {D8192518-30ED-4BE8-ABFD-BEFEC80887A6} 117995792 1 204004352 427228
09:22:05.703 [4468.1884] <2> EndpointSelector_R2::updateConfMembers: epsr2: bp.conf LastUpd=1393495990 bp.conf LastLook=1393534830(Endpoint_Selector.cpp:403)
09:22:05.703 [4468.1884] <2> EndpointSelectorFactory::get_selector: epsr2: got 7.x EPS(Endpoint_Selector.cpp:2019)
09:22:05.703 [4468.1884] <2> EndpointSelector_R2::select_endpoint: epsr2: EPS Honoring Server List(Endpoint_Selector.cpp:530)
09:22:05.703 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Evaluating 3 endpoints(Endpoint_Selector.cpp:631)
09:22:05.718 [4468.1884] <2> ConnectList::search: host 146.253.66.129 found GOOD(ConnectList.cpp:91)
09:22:05.718 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Reusing endpoint, target: 146.253.66.129, source: ANY(Endpoint_Selector.cpp:688)
09:22:05.718 [4468.1884] <2> VxssContext::updateOnFailure: epsr2: updateOnFailure?=0 useVxss=2(Endpoint_Selector.cpp:243)
09:22:05.718 [4468.1884] <2> EndpointSelector_R2::performCallUsingEndpoint: epsr2: insecure invocation->perform_call(...) to host 146.253.66.129 SUCCESS(Endpoint_Selector.cpp:1198)
09:22:05.718 [4468.1884] <2> ConnectList::update: updated host 146.253.66.129 as GOOD, used 0 of 3 retries(ConnectList.cpp:180)
09:22:05.718 [4468.1884] <2> JobInst::sendIrmMsg: returning
09:25:44.696 [4468.1884] <2> write_backup: write_data() returned, exit_status = 0, CINDEX = 0, TWIN_INDEX = 0, backup_status = -6
09:25:44.696 [4468.1884] <2> write_backup: maximum fragment size written copy 1 --- Fragmenting
09:25:44.696 [4468.1884] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:25:44.712 [4468.1884] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:25:44.712 [4468.1884] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50552 TO 146.253.66.129.1556 fd = 736
09:25:44.712 [4468.1884] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:25:44.743 [4468.1884] <2> db_end: Need to collect reply
09:25:44.743 [4468.1884] <4> report_throughput: VBRT 1 4468 5 1 PureDiskVolume @aaab3 0 1 0 4785152  4785152 (bptm.c.20638)
09:26:01.404 [4468.1884] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 70
09:26:01.419 [4468.1884] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:26:01.419 [4468.1884] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50560 TO 146.253.66.129.1556 fd = 736
09:26:01.419 [4468.1884] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:26:01.450 [4468.1884] <2> db_end: Need to collect reply
09:26:01.700 [4468.1884] <2> construct_sts_isid: master_server adm-master01, client sehud0001msx.no001.siemens.net, backup_time 1393534804, copy_number 1, stream_number 0, fragment_number 5, resume_number 0, spl_name NULL
09:26:03.026 [4468.1884] <2> io_open_disk: file sehud0001msx.no001.siemens.net_1393534804_C1_F5 successfully opened
09:26:03.026 [4468.1884] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 77
09:26:03.042 [4468.1884] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:26:03.042 [4468.1884] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50566 TO 146.253.66.129.1556 fd = 1304
09:26:03.042 [4468.1884] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:26:03.073 [4468.1884] <2> db_end: Need to collect reply
09:26:03.338 [4468.1884] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:26:03.354 [4468.1884] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:26:03.354 [4468.1884] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50567 TO 146.253.66.129.1556 fd = 1480
09:26:03.354 [4468.1884] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:26:03.400 [4468.1884] <2> db_end: Need to collect reply
09:26:03.400 [4468.1884] <4> write_backup: successfully wrote backup id sehud0001msx.no001.siemens.net_1393534804, copy 1, fragment 4, 51200000 Kbytes at 3388.703 Kbytes/sec
09:26:03.400 [4468.1884] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:26:03.416 [4468.1884] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:26:03.416 [4468.1884] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50568 TO 146.253.66.129.1556 fd = 1480
09:26:03.416 [4468.1884] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:26:03.463 [4468.1884] <2> db_end: Need to collect reply
09:26:03.463 [4468.1884] <4> write_backup: begin writing backup id sehud0001msx.no001.siemens.net_1393534804, copy 1, fragment 5, destination path PureDiskVolume
09:26:03.463 [4468.1884] <2> write_data: twin_index: 0 active: 1 dont_process: 0 wrote_backup_hdr: 0 finished_buff: 0 saved_cindex: -1 twin_is_disk 1 delay_brm: 0
09:26:03.463 [4468.1884] <2> write_data: Total Kbytes transferred 204800000
09:26:03.463 [4468.1884] <2> write_data: first write, twin_index: 0 cindex: 0 dont_process: 1 wrote_backup_hdr: 0 finished_buff: 0
09:26:03.463 [4468.1884] <2> write_data: received first buffer (262144 bytes), begin writing data
09:28:36.062 [2496.6948] <2> bptm: INITIATING (VERBOSE = 0): -rptdrv -jobid -1393107456 -jm 
09:28:36.062 [2496.6948] <2> drivename_open: Called with Create 0, file HP.ULTRIUM3-SCSI.006
09:28:36.062 [2496.6948] <2> drivename_checklock: Called
09:28:36.062 [2496.6948] <2> report_drives: DRIVE = HP.ULTRIUM3-SCSI.006 LOCK = FALSE CURTIME = 1393576116
09:28:36.062 [2496.6948] <2> drivename_close: Called for file HP.ULTRIUM3-SCSI.006
09:28:36.062 [2496.6948] <2> report_drives: MODE = 2
09:28:36.062 [2496.6948] <2> report_drives: TIME = 1380779946
09:28:36.062 [2496.6948] <2> report_drives: MASTER = adm-master01
09:28:36.062 [2496.6948] <2> report_drives: SR_KEY = 551550983 2000465
09:28:36.062 [2496.6948] <2> report_drives: PATH = {3,0,0,0}
09:28:36.062 [2496.6948] <2> report_drives: REQID = -1380722903
09:28:36.062 [2496.6948] <2> report_drives: ALOCID = 111350286
09:28:36.062 [2496.6948] <2> report_drives: RBID = {C5C42F0A-1F7A-43C3-BFD3-8BA29A763928}
09:28:36.062 [2496.6948] <2> report_drives: PID = 7832
09:28:36.062 [2496.6948] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_HP.ULTRIUM3-SCSI.006
09:28:36.062 [2496.6948] <2> drivename_open: Called with Create 0, file IBM.ULT3580-TD5.Drive2
09:28:36.062 [2496.6948] <2> drivename_checklock: Called
09:28:36.062 [2496.6948] <2> report_drives: DRIVE = IBM.ULT3580-TD5.Drive2 LOCK = FALSE CURTIME = 1393576116
09:28:36.062 [2496.6948] <2> drivename_close: Called for file IBM.ULT3580-TD5.Drive2
09:28:36.062 [2496.6948] <2> report_drives: MODE = 2
09:28:36.062 [2496.6948] <2> report_drives: TIME = 1393480716
09:28:36.062 [2496.6948] <2> report_drives: MASTER = adm-master01
09:28:36.062 [2496.6948] <2> report_drives: SR_KEY = 3905945607 2000495
09:28:36.062 [2496.6948] <2> report_drives: PATH = {3,0,7,0}
09:28:36.062 [2496.6948] <2> report_drives: REQID = -1393099837
09:28:36.062 [2496.6948] <2> report_drives: ALOCID = 117960333
09:28:36.062 [2496.6948] <2> report_drives: RBID = {B062D34D-CC24-433D-BEA3-AD9CF91C2B5E}
09:28:36.062 [2496.6948] <2> report_drives: PID = 7640
09:28:36.062 [2496.6948] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_IBM.ULT3580-TD5.Drive2
09:28:36.062 [2496.6948] <2> main: Sending [EXIT STATUS 0] to NBJM
09:28:36.062 [2496.6948] <2> bptm: EXITING with status 0 <----------
09:31:13.763 [4148.8084] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:31:13.763 [4148.8084] <8> file_to_cache_item: [vnet_addrinfo.c:6577] fopen() failed ERRNO=2 FILE=C:\Program Files\Veritas\NetBackup\var\host_cache\146\ca608546+0,1,a,0,1,0+seskv01srv01.no001.siemens.net.txt
09:31:13.763 [4148.8084] <8> file_to_cache_item: [vnet_addrinfo.c:6577] fopen() failed ERRNO=2 FILE=C:\Program Files\Veritas\NetBackup\var\host_cache\163\94d6a963+0,1,a,0,1,0+sesdl01srv01.no001.siemens.net.txt
09:31:13.763 [4148.8084] <8> file_to_cache_item: [vnet_addrinfo.c:6577] fopen() failed ERRNO=2 FILE=C:\Program Files\Veritas\NetBackup\var\host_cache\171\f0eb8171+0,1,a,0,1,0+segot01srv01.no001.siemens.net.txt
09:31:13.763 [4148.8084] <8> file_to_cache_item: [vnet_addrinfo.c:6577] fopen() failed ERRNO=2 FILE=C:\Program Files\Veritas\NetBackup\var\host_cache\1ea\a8d279ea+0,1,a,0,1,0+sebox01srv01.no001.siemens.net.txt
09:31:13.794 [4148.8084] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:31:13.794 [4148.8084] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50626 TO 146.253.66.129.1556 fd = 1520
09:31:13.794 [4148.8084] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:31:13.825 [4148.8084] <2> db_end: Need to collect reply
09:31:13.825 [4148.8084] <4> report_throughput: VBRT 1 4148 1 1 PureDiskVolume @aaab3 0 1 0 2202112  2202112 (bptm.c.25633)
09:31:13.825 [4148.8084] <2> write_data: Total Kbytes transferred 32431104
09:34:19.902 [4468.1884] <2> send_MDS_msg: KBYTES_WRITTEN 0 {D8192518-30ED-4BE8-ABFD-BEFEC80887A6} 117995792 1 207004416 427228
09:34:19.902 [4468.1884] <2> EndpointSelector_R2::updateConfMembers: epsr2: bp.conf LastUpd=1393495990 bp.conf LastLook=1393534830(Endpoint_Selector.cpp:403)
09:34:19.902 [4468.1884] <2> EndpointSelectorFactory::get_selector: epsr2: got 7.x EPS(Endpoint_Selector.cpp:2019)
09:34:19.902 [4468.1884] <2> EndpointSelector_R2::select_endpoint: epsr2: EPS Honoring Server List(Endpoint_Selector.cpp:530)
09:34:19.902 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Evaluating 3 endpoints(Endpoint_Selector.cpp:631)
09:34:19.902 [4468.1884] <2> ConnectList::search: host 146.253.66.129 found GOOD(ConnectList.cpp:91)
09:34:19.902 [4468.1884] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Reusing endpoint, target: 146.253.66.129, source: ANY(Endpoint_Selector.cpp:688)
09:34:19.902 [4468.1884] <2> VxssContext::updateOnFailure: epsr2: updateOnFailure?=0 useVxss=2(Endpoint_Selector.cpp:243)
09:34:19.902 [4468.1884] <2> EndpointSelector_R2::performCallUsingEndpoint: epsr2: insecure invocation->perform_call(...) to host 146.253.66.129 SUCCESS(Endpoint_Selector.cpp:1198)
09:34:19.902 [4468.1884] <2> ConnectList::update: updated host 146.253.66.129 as GOOD, used 0 of 3 retries(ConnectList.cpp:180)
09:34:19.902 [4468.1884] <2> JobInst::sendIrmMsg: returning
09:34:52.678 [4148.8084] <2> send_MDS_msg: KBYTES_WRITTEN 0 {86FE2AAC-D076-4858-A4B4-37DF07C1A432} 118018837 1 33000704 428737
09:34:52.678 [4148.8084] <2> EndpointSelector_R2::updateConfMembers: epsr2: bp.conf LastUpd=1393495990 bp.conf LastLook=1393555898(Endpoint_Selector.cpp:403)
09:34:52.678 [4148.8084] <2> EndpointSelectorFactory::get_selector: epsr2: got 7.x EPS(Endpoint_Selector.cpp:2019)
09:34:52.678 [4148.8084] <2> EndpointSelector_R2::select_endpoint: epsr2: EPS Honoring Server List(Endpoint_Selector.cpp:530)
09:34:52.678 [4148.8084] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Evaluating 3 endpoints(Endpoint_Selector.cpp:631)
09:34:52.678 [4148.8084] <2> ConnectList::search: host 146.253.66.129 found GOOD(ConnectList.cpp:91)
09:34:52.678 [4148.8084] <2> EndpointSelector_R2::endpoint_from_profile: epsr2: Reusing endpoint, target: 146.253.66.129, source: ANY(Endpoint_Selector.cpp:688)
09:34:52.678 [4148.8084] <2> VxssContext::updateOnFailure: epsr2: updateOnFailure?=0 useVxss=2(Endpoint_Selector.cpp:243)
09:34:52.678 [4148.8084] <2> EndpointSelector_R2::performCallUsingEndpoint: epsr2: insecure invocation->perform_call(...) to host 146.253.66.129 SUCCESS(Endpoint_Selector.cpp:1198)
09:34:52.678 [4148.8084] <2> ConnectList::update: updated host 146.253.66.129 as GOOD, used 0 of 3 retries(ConnectList.cpp:180)
09:34:52.678 [4148.8084] <2> JobInst::sendIrmMsg: returning
09:38:36.024 [8360.7112] <2> bptm: INITIATING (VERBOSE = 0): -rptdrv -jobid -1393107483 -jm 
09:38:36.024 [8360.7112] <2> drivename_open: Called with Create 0, file HP.ULTRIUM3-SCSI.006
09:38:36.024 [8360.7112] <2> drivename_checklock: Called
09:38:36.024 [8360.7112] <2> report_drives: DRIVE = HP.ULTRIUM3-SCSI.006 LOCK = FALSE CURTIME = 1393576716
09:38:36.024 [8360.7112] <2> drivename_close: Called for file HP.ULTRIUM3-SCSI.006
09:38:36.024 [8360.7112] <2> report_drives: MODE = 2
09:38:36.024 [8360.7112] <2> report_drives: TIME = 1380779946
09:38:36.024 [8360.7112] <2> report_drives: MASTER = adm-master01
09:38:36.024 [8360.7112] <2> report_drives: SR_KEY = 551550983 2000465
09:38:36.024 [8360.7112] <2> report_drives: PATH = {3,0,0,0}
09:38:36.024 [8360.7112] <2> report_drives: REQID = -1380722903
09:38:36.024 [8360.7112] <2> report_drives: ALOCID = 111350286
09:38:36.024 [8360.7112] <2> report_drives: RBID = {C5C42F0A-1F7A-43C3-BFD3-8BA29A763928}
09:38:36.024 [8360.7112] <2> report_drives: PID = 7832
09:38:36.024 [8360.7112] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_HP.ULTRIUM3-SCSI.006
09:38:36.024 [8360.7112] <2> drivename_open: Called with Create 0, file IBM.ULT3580-TD5.Drive2
09:38:36.024 [8360.7112] <2> drivename_checklock: Called
09:38:36.024 [8360.7112] <2> report_drives: DRIVE = IBM.ULT3580-TD5.Drive2 LOCK = FALSE CURTIME = 1393576716
09:38:36.024 [8360.7112] <2> drivename_close: Called for file IBM.ULT3580-TD5.Drive2
09:38:36.024 [8360.7112] <2> report_drives: MODE = 2
09:38:36.024 [8360.7112] <2> report_drives: TIME = 1393480716
09:38:36.024 [8360.7112] <2> report_drives: MASTER = adm-master01
09:38:36.024 [8360.7112] <2> report_drives: SR_KEY = 3905945607 2000495
09:38:36.024 [8360.7112] <2> report_drives: PATH = {3,0,7,0}
09:38:36.024 [8360.7112] <2> report_drives: REQID = -1393099837
09:38:36.024 [8360.7112] <2> report_drives: ALOCID = 117960333
09:38:36.024 [8360.7112] <2> report_drives: RBID = {B062D34D-CC24-433D-BEA3-AD9CF91C2B5E}
09:38:36.024 [8360.7112] <2> report_drives: PID = 7640
09:38:36.024 [8360.7112] <2> report_drives: FILE = C:\Program Files\Veritas\NetBackup\db\media\tpreq\drive_IBM.ULT3580-TD5.Drive2
09:38:36.024 [8360.7112] <2> main: Sending [EXIT STATUS 0] to NBJM
09:38:36.024 [8360.7112] <2> bptm: EXITING with status 0 <----------
09:40:37.517 [4148.8084] <2> write_data: writing block shorter than BUFF_SIZE, 57344 bytes
09:40:37.517 [4148.8084] <2> bp_sts_write_and_include_image: Total Include Segments = 0, Total Include Validation = 0
09:40:37.517 [4148.8084] <2> write_data: writing short block, 57344 bytes, remainder 0
09:40:37.517 [4148.8084] <2> write_data: waited for full buffer 5 times, delayed 5597 times
09:40:37.517 [4148.8084] <2> write_data: Total Kbytes transferred 33642040
09:40:37.517 [4148.8084] <2> write_backup: write_data() returned, exit_status = 0, CINDEX = 0, TWIN_INDEX = 0, backup_status = 0
09:40:37.517 [4148.8084] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:40:37.532 [4148.8084] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:40:37.532 [4148.8084] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50724 TO 146.253.66.129.1556 fd = 1516
09:40:37.532 [4148.8084] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:40:37.595 [4148.8084] <2> db_end: Need to collect reply
09:40:37.610 [4148.8084] <4> report_throughput: VBRT 1 4148 5 1 PureDiskVolume @aaab3 0 1 0 1210936  1210936 (bptm.c.20638)
09:40:54.022 [4148.8084] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 70
09:40:54.022 [4148.8084] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:40:54.022 [4148.8084] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50734 TO 146.253.66.129.1556 fd = 1512
09:40:54.022 [4148.8084] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:40:54.053 [4148.8084] <2> db_end: Need to collect reply
09:40:54.318 [4148.8084] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 1
09:40:54.334 [4148.8084] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:40:54.334 [4148.8084] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50736 TO 146.253.66.129.1556 fd = 1520
09:40:54.334 [4148.8084] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
09:40:54.365 [4148.8084] <2> db_end: Need to collect reply
09:40:54.365 [4148.8084] <4> write_backup: successfully wrote backup id em-spntdb01_1393555886, copy 1, fragment 1, 33642040 Kbytes at 1607.786 Kbytes/sec
09:40:54.365 [4148.8084] <2> ConnectionCache::connectAndCache: Acquiring new connection for host adm-master01, query type 60
09:40:54.380 [4148.8084] <2> vnet_pbxConnect: pbxConnectEx Succeeded
09:40:54.380 [4148.8084] <2> logconnections: BPDBM CONNECT FROM 146.253.66.134.50737 TO 146.253.66.129.1556 fd = 1512
09:40:54.380 [4148.8084] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2