{\rtf1\ansi\deff0{\fonttbl{\f0\fnil\fcharset0 Courier New;}} {\*\generator Msftedit 5.41.21.2510;}\viewkind4\uc1\pard\lang1033\f0\fs22 09:32:29.637 [9181] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 09:32:29.637 [9181] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 09:32:29.637 [9181] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 09:32:29.637 [9181] <2> int_GetMMInfo: INF - Initialized Signal\par 09:32:29.637 [9181] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 09:32:30.216 [9182] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 09:32:30.216 [9182] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 09:32:30.216 [9182] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 09:32:30.216 [9182] <2> int_GetMMInfo: INF - Initialized Signal\par 09:32:30.216 [9182] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 09:32:31.451 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:32:31.451 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 09:32:31.454 [9182] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 09:32:31.454 [9182] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44327 TO 25.1.1.131.1556 fd = 17\par 09:32:31.458 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:32:31.458 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 09:32:31.468 [9181] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 09:32:31.469 [9181] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44328 TO 25.1.1.131.1556 fd = 17\par 09:32:31.534 [9182] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 09:32:31.552 [9182] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 09:32:31.553 [9182] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44329 TO 25.1.1.131.1556 fd = 18\par 09:32:31.563 [9181] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 09:32:31.574 [9181] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 09:32:31.574 [9181] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44330 TO 25.1.1.131.1556 fd = 18\par 09:32:39.644 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 09:32:39.644 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 09:32:39.644 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 09:32:39.644 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 09:32:39.644 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 09:32:39.644 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 09:32:39.645 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 09:32:39.645 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 1336\par 09:32:39.645 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:32:39.645 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+1336,1,4,2,2,0+bmmi-db-prsrv2.txt\par 09:32:39.645 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 09:32:39.645 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 09:32:39.646 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 09:32:39.646 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 09:32:39.646 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 09:32:39.646 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 09:32:39.646 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 09:32:39.646 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3506\par 09:32:39.646 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:32:39.646 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3506,1,4,2,2,0+bmmi-db-prsrv2.txt\par 09:32:39.647 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 09:32:39.647 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 09:32:39.647 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 09:32:39.647 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 09:32:39.647 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 09:32:39.647 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 09:32:39.647 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 09:32:39.647 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4608\par 09:32:39.647 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:32:39.647 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4608,1,4,2,2,0+bmmi-db-prsrv2.txt\par 09:33:39.044 [9181] <2> int_StartJob: INF - copyID: 1 - 1330410277\par \par 09:33:39.134 [9181] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 09:33:42.500 [9181] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 09:33:45.550 [9181] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 09:33:49.039 [9181] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 09:33:52.678 [9181] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 09:33:56.345 [9181] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 09:33:59.641 [9181] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 09:34:02.856 [9181] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 09:34:06.179 [9181] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 09:34:09.524 [9181] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 09:34:13.298 [9181] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 09:34:17.031 [9181] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 09:34:20.598 [9181] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 09:34:24.164 [9181] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 09:34:27.708 [9181] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 09:34:31.252 [9181] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 09:34:34.873 [9181] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 09:34:38.550 [9181] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 09:34:42.119 [9181] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 09:34:45.658 [9181] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 09:34:49.280 [9181] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 09:34:52.920 [9181] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 09:34:56.666 [9181] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 09:35:00.193 [9181] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 09:35:03.822 [9181] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 09:35:07.730 [9181] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 09:35:11.466 [9181] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 09:35:15.143 [9181] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 09:35:19.026 [9181] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 09:35:22.867 [9181] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 09:35:27.336 [9181] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 09:35:30.853 [9181] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 09:35:34.538 [9181] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 09:35:38.038 [9181] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 09:35:41.732 [9181] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 09:35:45.250 [9181] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 09:35:48.870 [9181] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 09:35:52.379 [9181] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 09:35:55.972 [9181] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 09:35:59.393 [9181] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 09:36:03.771 [9181] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 09:36:07.297 [9181] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 09:36:10.839 [9181] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 09:36:14.323 [9181] <2> int_WriteData: INF - writing buffer # 43000 of size 262144\par 09:36:18.204 [9181] <2> int_WriteData: INF - writing buffer # 44000 of size 262144\par 09:36:21.844 [9181] <2> int_WriteData: INF - writing buffer # 45000 of size 262144\par 09:36:25.329 [9181] <2> int_WriteData: INF - writing buffer # 46000 of size 262144\par 09:36:29.495 [9181] <2> int_WriteData: INF - writing buffer # 47000 of size 262144\par 09:36:32.990 [9181] <2> int_WriteData: INF - writing buffer # 48000 of size 262144\par 09:36:36.559 [9181] <2> int_WriteData: INF - writing buffer # 49000 of size 262144\par 09:36:40.224 [9181] <2> int_WriteData: INF - writing buffer # 50000 of size 262144\par 09:36:43.795 [9181] <2> int_WriteData: INF - writing buffer # 51000 of size 262144\par 09:36:47.683 [9181] <2> int_WriteData: INF - writing buffer # 52000 of size 262144\par 09:36:51.618 [9181] <2> int_WriteData: INF - writing buffer # 53000 of size 262144\par 09:36:55.797 [9181] <2> int_WriteData: INF - writing buffer # 54000 of size 262144\par 09:36:59.375 [9181] <2> int_WriteData: INF - writing buffer # 55000 of size 262144\par 09:37:02.964 [9181] <2> int_WriteData: INF - writing buffer # 56000 of size 262144\par 09:37:06.619 [9181] <2> int_WriteData: INF - writing buffer # 57000 of size 262144\par 09:37:10.227 [9181] <2> int_WriteData: INF - writing buffer # 58000 of size 262144\par 09:37:13.987 [9181] <2> int_WriteData: INF - writing buffer # 59000 of size 262144\par 09:37:17.715 [9181] <2> int_WriteData: INF - writing buffer # 60000 of size 262144\par 09:37:21.576 [9181] <2> int_WriteData: INF - writing buffer # 61000 of size 262144\par 09:37:25.231 [9181] <2> int_WriteData: INF - writing buffer # 62000 of size 262144\par 09:37:28.962 [9181] <2> int_WriteData: INF - writing buffer # 63000 of size 262144\par 09:37:32.409 [9181] <2> int_WriteData: INF - writing buffer # 64000 of size 262144\par 09:37:35.962 [9181] <2> int_WriteData: INF - writing buffer # 65000 of size 262144\par 09:37:39.465 [9181] <2> int_WriteData: INF - writing buffer # 66000 of size 262144\par 09:37:43.048 [9181] <2> int_WriteData: INF - writing buffer # 67000 of size 262144\par 09:37:46.488 [9181] <2> int_WriteData: INF - writing buffer # 68000 of size 262144\par 09:37:50.168 [9181] <2> int_WriteData: INF - writing buffer # 69000 of size 262144\par 09:37:53.822 [9181] <2> int_WriteData: INF - writing buffer # 70000 of size 262144\par 09:37:57.325 [9181] <2> int_WriteData: INF - writing buffer # 71000 of size 262144\par 09:38:00.773 [9181] <2> int_WriteData: INF - writing buffer # 72000 of size 262144\par 09:38:04.628 [9181] <2> int_WriteData: INF - writing buffer # 73000 of size 262144\par 09:38:08.082 [9181] <2> int_WriteData: INF - writing buffer # 74000 of size 262144\par 09:38:11.438 [9181] <2> int_WriteData: INF - writing buffer # 75000 of size 262144\par 09:38:14.849 [9181] <2> int_WriteData: INF - writing buffer # 76000 of size 262144\par 09:38:18.553 [9181] <2> int_WriteData: INF - writing buffer # 77000 of size 262144\par 09:38:21.988 [9181] <2> int_WriteData: INF - writing buffer # 78000 of size 262144\par 09:38:25.782 [9181] <2> int_WriteData: INF - writing buffer # 79000 of size 262144\par 09:38:29.444 [9181] <2> int_WriteData: INF - writing buffer # 80000 of size 262144\par 09:38:33.427 [9181] <2> int_WriteData: INF - writing buffer # 81000 of size 262144\par 09:38:36.966 [9181] <2> int_WriteData: INF - writing buffer # 82000 of size 262144\par 09:38:40.556 [9181] <2> int_WriteData: INF - writing buffer # 83000 of size 262144\par 09:38:44.279 [9181] <2> int_WriteData: INF - writing buffer # 84000 of size 262144\par 09:38:47.881 [9181] <2> int_WriteData: INF - writing buffer # 85000 of size 262144\par 09:38:51.489 [9181] <2> int_WriteData: INF - writing buffer # 86000 of size 262144\par 09:38:55.446 [9181] <2> int_WriteData: INF - writing buffer # 87000 of size 262144\par 09:38:59.251 [9181] <2> int_WriteData: INF - writing buffer # 88000 of size 262144\par 09:39:02.796 [9181] <2> int_WriteData: INF - writing buffer # 89000 of size 262144\par 09:39:06.542 [9181] <2> int_WriteData: INF - writing buffer # 90000 of size 262144\par 09:39:10.044 [9181] <2> int_WriteData: INF - writing buffer # 91000 of size 262144\par 09:39:13.432 [9181] <2> int_WriteData: INF - writing buffer # 92000 of size 262144\par 09:39:16.931 [9181] <2> int_WriteData: INF - writing buffer # 93000 of size 262144\par 09:39:20.267 [9181] <2> int_WriteData: INF - writing buffer # 94000 of size 262144\par 09:39:23.831 [9181] <2> int_WriteData: INF - writing buffer # 95000 of size 262144\par 09:39:27.417 [9181] <2> int_WriteData: INF - writing buffer # 96000 of size 262144\par 09:39:31.262 [9181] <2> int_WriteData: INF - writing buffer # 97000 of size 262144\par 09:39:34.703 [9181] <2> int_WriteData: INF - writing buffer # 98000 of size 262144\par 09:39:38.169 [9181] <2> int_WriteData: INF - writing buffer # 99000 of size 262144\par 09:39:41.578 [9181] <2> int_WriteData: INF - writing buffer # 100000 of size 262144\par 09:39:45.177 [9181] <2> int_WriteData: INF - writing buffer # 101000 of size 262144\par 09:39:48.702 [9181] <2> int_WriteData: INF - writing buffer # 102000 of size 262144\par 09:39:52.210 [9181] <2> int_WriteData: INF - writing buffer # 103000 of size 262144\par 09:39:55.832 [9181] <2> int_WriteData: INF - writing buffer # 104000 of size 262144\par 09:39:59.492 [9181] <2> int_WriteData: INF - writing buffer # 105000 of size 262144\par 09:40:03.101 [9181] <2> int_WriteData: INF - writing buffer # 106000 of size 262144\par 09:40:06.686 [9181] <2> int_WriteData: INF - writing buffer # 107000 of size 262144\par 09:40:10.230 [9181] <2> int_WriteData: INF - writing buffer # 108000 of size 262144\par 09:40:13.576 [9181] <2> int_WriteData: INF - writing buffer # 109000 of size 262144\par 09:40:17.150 [9181] <2> int_WriteData: INF - writing buffer # 110000 of size 262144\par 09:40:20.862 [9181] <2> int_WriteData: INF - writing buffer # 111000 of size 262144\par 09:40:24.542 [9181] <2> int_WriteData: INF - writing buffer # 112000 of size 262144\par 09:40:28.306 [9181] <2> int_WriteData: INF - writing buffer # 113000 of size 262144\par 09:40:31.924 [9181] <2> int_WriteData: INF - writing buffer # 114000 of size 262144\par 09:40:36.036 [9181] <2> int_WriteData: INF - writing buffer # 115000 of size 262144\par 09:40:39.835 [9181] <2> int_WriteData: INF - writing buffer # 116000 of size 262144\par 09:40:43.464 [9181] <2> int_WriteData: INF - writing buffer # 117000 of size 262144\par 09:40:47.301 [9181] <2> int_WriteData: INF - writing buffer # 118000 of size 262144\par 09:40:51.058 [9181] <2> int_WriteData: INF - writing buffer # 119000 of size 262144\par 09:40:54.981 [9181] <2> int_WriteData: INF - writing buffer # 120000 of size 262144\par 09:40:58.755 [9181] <2> int_WriteData: INF - writing buffer # 121000 of size 262144\par 09:41:02.335 [9181] <2> int_WriteData: INF - writing buffer # 122000 of size 262144\par 09:41:06.049 [9181] <2> int_WriteData: INF - writing buffer # 123000 of size 262144\par 09:41:11.751 [9181] <2> int_WriteData: INF - writing buffer # 124000 of size 262144\par 09:41:15.427 [9181] <2> int_WriteData: INF - writing buffer # 125000 of size 262144\par 09:41:19.198 [9181] <2> int_WriteData: INF - writing buffer # 126000 of size 262144\par 09:41:22.804 [9181] <2> int_WriteData: INF - writing buffer # 127000 of size 262144\par 09:41:26.455 [9181] <2> int_WriteData: INF - writing buffer # 128000 of size 262144\par 09:41:30.001 [9181] <2> int_WriteData: INF - writing buffer # 129000 of size 262144\par 09:41:33.971 [9181] <2> int_WriteData: INF - writing buffer # 130000 of size 262144\par 09:41:37.668 [9181] <2> int_WriteData: INF - writing buffer # 131000 of size 262144\par 09:41:41.460 [9181] <2> int_WriteData: INF - writing buffer # 132000 of size 262144\par 09:41:45.314 [9181] <2> int_WriteData: INF - writing buffer # 133000 of size 262144\par 09:41:48.953 [9181] <2> int_WriteData: INF - writing buffer # 134000 of size 262144\par 09:41:52.987 [9181] <2> int_WriteData: INF - writing buffer # 135000 of size 262144\par 09:41:56.799 [9181] <2> int_WriteData: INF - writing buffer # 136000 of size 262144\par 09:42:00.520 [9181] <2> int_WriteData: INF - writing buffer # 137000 of size 262144\par 09:42:04.491 [9181] <2> int_WriteData: INF - writing buffer # 138000 of size 262144\par 09:42:08.503 [9181] <2> int_WriteData: INF - writing buffer # 139000 of size 262144\par 09:42:12.549 [9181] <2> int_WriteData: INF - writing buffer # 140000 of size 262144\par 09:42:16.650 [9181] <2> int_WriteData: INF - writing buffer # 141000 of size 262144\par 09:42:20.435 [9181] <2> int_WriteData: INF - writing buffer # 142000 of size 262144\par 09:42:24.596 [9181] <2> int_WriteData: INF - writing buffer # 143000 of size 262144\par 09:42:28.647 [9181] <2> int_WriteData: INF - writing buffer # 144000 of size 262144\par 09:42:32.634 [9181] <2> int_WriteData: INF - writing buffer # 145000 of size 262144\par 09:42:36.451 [9181] <2> int_WriteData: INF - writing buffer # 146000 of size 262144\par 09:42:40.508 [9181] <2> int_WriteData: INF - writing buffer # 147000 of size 262144\par 09:42:44.430 [9181] <2> int_WriteData: INF - writing buffer # 148000 of size 262144\par 09:42:48.255 [9181] <2> int_WriteData: INF - writing buffer # 149000 of size 262144\par 09:42:52.167 [9181] <2> int_WriteData: INF - writing buffer # 150000 of size 262144\par 09:42:56.917 [9181] <2> int_WriteData: INF - writing buffer # 151000 of size 262144\par 09:43:00.845 [9181] <2> int_WriteData: INF - writing buffer # 152000 of size 262144\par 09:43:05.034 [9181] <2> int_WriteData: INF - writing buffer # 153000 of size 262144\par 09:43:09.432 [9181] <2> int_WriteData: INF - writing buffer # 154000 of size 262144\par 09:43:13.719 [9181] <2> int_WriteData: INF - writing buffer # 155000 of size 262144\par 09:43:18.220 [9181] <2> int_WriteData: INF - writing buffer # 156000 of size 262144\par 09:43:23.135 [9181] <2> int_WriteData: INF - writing buffer # 157000 of size 262144\par 09:43:27.920 [9181] <2> int_WriteData: INF - writing buffer # 158000 of size 262144\par 09:43:32.186 [9181] <2> int_WriteData: INF - writing buffer # 159000 of size 262144\par 09:43:36.290 [9181] <2> int_WriteData: INF - writing buffer # 160000 of size 262144\par 09:43:40.616 [9181] <2> int_WriteData: INF - writing buffer # 161000 of size 262144\par 09:43:45.134 [9181] <2> int_WriteData: INF - writing buffer # 162000 of size 262144\par 09:43:50.765 [9181] <2> int_WriteData: INF - writing buffer # 163000 of size 262144\par 09:43:55.684 [9181] <2> int_WriteData: INF - writing buffer # 164000 of size 262144\par 09:44:00.040 [9181] <2> int_WriteData: INF - writing buffer # 165000 of size 262144\par 09:44:04.519 [9181] <2> int_WriteData: INF - writing buffer # 166000 of size 262144\par 09:44:08.618 [9181] <2> int_WriteData: INF - writing buffer # 167000 of size 262144\par 09:44:12.667 [9181] <2> int_WriteData: INF - writing buffer # 168000 of size 262144\par 09:44:16.567 [9181] <2> int_WriteData: INF - writing buffer # 169000 of size 262144\par 09:44:20.961 [9181] <2> int_WriteData: INF - writing buffer # 170000 of size 262144\par 09:44:25.156 [9181] <2> int_WriteData: INF - writing buffer # 171000 of size 262144\par 09:44:29.226 [9181] <2> int_WriteData: INF - writing buffer # 172000 of size 262144\par 09:44:33.534 [9181] <2> int_WriteData: INF - writing buffer # 173000 of size 262144\par 09:44:37.820 [9181] <2> int_WriteData: INF - writing buffer # 174000 of size 262144\par 09:44:41.929 [9181] <2> int_WriteData: INF - writing buffer # 175000 of size 262144\par 09:44:46.391 [9181] <2> int_WriteData: INF - writing buffer # 176000 of size 262144\par 09:44:50.481 [9181] <2> int_WriteData: INF - writing buffer # 177000 of size 262144\par 09:44:54.206 [9181] <2> int_WriteData: INF - writing buffer # 178000 of size 262144\par 09:44:58.149 [9181] <2> int_WriteData: INF - writing buffer # 179000 of size 262144\par 09:45:01.819 [9181] <2> int_WriteData: INF - writing buffer # 180000 of size 262144\par 09:45:05.597 [9181] <2> int_WriteData: INF - writing buffer # 181000 of size 262144\par 09:45:09.485 [9181] <2> int_WriteData: INF - writing buffer # 182000 of size 262144\par 09:45:13.212 [9181] <2> int_WriteData: INF - writing buffer # 183000 of size 262144\par 09:45:16.611 [9181] <2> int_WriteData: INF - writing buffer # 184000 of size 262144\par 09:45:20.436 [9181] <2> int_WriteData: INF - writing buffer # 185000 of size 262144\par 09:45:24.163 [9181] <2> int_WriteData: INF - writing buffer # 186000 of size 262144\par 09:45:28.019 [9181] <2> int_WriteData: INF - writing buffer # 187000 of size 262144\par 09:45:31.574 [9181] <2> int_WriteData: INF - writing buffer # 188000 of size 262144\par 09:45:35.297 [9181] <2> int_WriteData: INF - writing buffer # 189000 of size 262144\par 09:45:39.087 [9181] <2> int_WriteData: INF - writing buffer # 190000 of size 262144\par 09:45:42.819 [9181] <2> int_WriteData: INF - writing buffer # 191000 of size 262144\par 09:45:46.615 [9181] <2> int_WriteData: INF - writing buffer # 192000 of size 262144\par 09:45:50.401 [9181] <2> int_WriteData: INF - writing buffer # 193000 of size 262144\par 09:45:54.359 [9181] <2> int_WriteData: INF - writing buffer # 194000 of size 262144\par 09:45:58.162 [9181] <2> int_WriteData: INF - writing buffer # 195000 of size 262144\par 09:46:01.861 [9181] <2> int_WriteData: INF - writing buffer # 196000 of size 262144\par 09:46:07.195 [9181] <2> int_WriteData: INF - writing buffer # 197000 of size 262144\par 09:46:11.152 [9181] <2> int_WriteData: INF - writing buffer # 198000 of size 262144\par 09:46:14.826 [9181] <2> int_WriteData: INF - writing buffer # 199000 of size 262144\par 09:46:18.783 [9181] <2> int_WriteData: INF - writing buffer # 200000 of size 262144\par 09:46:22.579 [9181] <2> int_WriteData: INF - writing buffer # 201000 of size 262144\par 09:46:26.666 [9181] <2> int_WriteData: INF - writing buffer # 202000 of size 262144\par 09:46:30.490 [9181] <2> int_WriteData: INF - writing buffer # 203000 of size 262144\par 09:46:35.028 [9181] <2> int_WriteData: INF - writing buffer # 204000 of size 262144\par 09:46:39.464 [9181] <2> int_WriteData: INF - writing buffer # 205000 of size 262144\par 09:46:44.064 [9181] <2> int_WriteData: INF - writing buffer # 206000 of size 262144\par 09:46:48.358 [9181] <2> int_WriteData: INF - writing buffer # 207000 of size 262144\par 09:46:52.275 [9181] <2> int_WriteData: INF - writing buffer # 208000 of size 262144\par 09:46:56.133 [9181] <2> int_WriteData: INF - writing buffer # 209000 of size 262144\par 09:47:00.180 [9181] <2> int_WriteData: INF - writing buffer # 210000 of size 262144\par 09:47:04.864 [9181] <2> int_WriteData: INF - writing buffer # 211000 of size 262144\par 09:47:10.219 [9181] <2> int_WriteData: INF - writing buffer # 212000 of size 262144\par 09:47:16.257 [9181] <2> int_WriteData: INF - writing buffer # 213000 of size 262144\par 09:47:22.897 [9181] <2> int_WriteData: INF - writing buffer # 214000 of size 262144\par 09:47:29.252 [9181] <2> int_WriteData: INF - writing buffer # 215000 of size 262144\par 09:47:35.513 [9181] <2> int_WriteData: INF - writing buffer # 216000 of size 262144\par 09:47:41.648 [9181] <2> int_WriteData: INF - writing buffer # 217000 of size 262144\par 09:47:47.478 [9181] <2> int_WriteData: INF - writing buffer # 218000 of size 262144\par 09:47:53.970 [9181] <2> int_WriteData: INF - writing buffer # 219000 of size 262144\par 09:48:00.116 [9181] <2> int_WriteData: INF - writing buffer # 220000 of size 262144\par 09:48:05.472 [9181] <2> int_WriteData: INF - writing buffer # 221000 of size 262144\par 09:48:11.822 [9181] <2> int_WriteData: INF - writing buffer # 222000 of size 262144\par 09:48:17.852 [9181] <2> int_WriteData: INF - writing buffer # 223000 of size 262144\par 09:48:24.107 [9181] <2> int_WriteData: INF - writing buffer # 224000 of size 262144\par 09:48:31.147 [9181] <2> int_WriteData: INF - writing buffer # 225000 of size 262144\par 09:48:37.598 [9181] <2> int_WriteData: INF - writing buffer # 226000 of size 262144\par 09:48:43.950 [9181] <2> int_WriteData: INF - writing buffer # 227000 of size 262144\par 09:48:50.060 [9181] <2> int_WriteData: INF - writing buffer # 228000 of size 262144\par 09:48:56.973 [9181] <2> int_WriteData: INF - writing buffer # 229000 of size 262144\par 09:49:03.718 [9181] <2> int_WriteData: INF - writing buffer # 230000 of size 262144\par 09:49:09.623 [9181] <2> int_WriteData: INF - writing buffer # 231000 of size 262144\par 09:49:17.130 [9181] <2> int_WriteData: INF - writing buffer # 232000 of size 262144\par 09:49:22.903 [9181] <2> int_WriteData: INF - writing buffer # 233000 of size 262144\par 09:49:27.506 [9181] <2> int_WriteData: INF - writing buffer # 234000 of size 262144\par 09:49:32.668 [9181] <2> int_WriteData: INF - writing buffer # 235000 of size 262144\par 09:49:38.680 [9181] <2> int_WriteData: INF - writing buffer # 236000 of size 262144\par 09:49:43.800 [9181] <2> int_WriteData: INF - writing buffer # 237000 of size 262144\par 09:49:48.509 [9181] <2> int_WriteData: INF - writing buffer # 238000 of size 262144\par 09:49:53.931 [9181] <2> int_WriteData: INF - writing buffer # 239000 of size 262144\par 09:49:59.609 [9181] <2> int_WriteData: INF - writing buffer # 240000 of size 262144\par 09:50:04.997 [9181] <2> int_WriteData: INF - writing buffer # 241000 of size 262144\par 09:50:10.254 [9181] <2> int_WriteData: INF - writing buffer # 242000 of size 262144\par 09:50:15.569 [9181] <2> int_WriteData: INF - writing buffer # 243000 of size 262144\par 09:50:20.880 [9181] <2> int_WriteData: INF - writing buffer # 244000 of size 262144\par 09:50:25.616 [9181] <2> int_WriteData: INF - writing buffer # 245000 of size 262144\par 09:50:30.037 [9181] <2> int_WriteData: INF - writing buffer # 246000 of size 262144\par 09:50:35.361 [9181] <2> int_WriteData: INF - writing buffer # 247000 of size 262144\par 09:50:40.414 [9181] <2> int_WriteData: INF - writing buffer # 248000 of size 262144\par 09:50:45.908 [9181] <2> int_WriteData: INF - writing buffer # 249000 of size 262144\par 09:50:51.694 [9181] <2> int_WriteData: INF - writing buffer # 250000 of size 262144\par 09:50:57.394 [9181] <2> int_WriteData: INF - writing buffer # 251000 of size 262144\par 09:51:03.264 [9181] <2> int_WriteData: INF - writing buffer # 252000 of size 262144\par 09:51:10.209 [9181] <2> int_WriteData: INF - writing buffer # 253000 of size 262144\par 09:51:16.529 [9181] <2> int_WriteData: INF - writing buffer # 254000 of size 262144\par 09:51:24.381 [9181] <2> int_WriteData: INF - writing buffer # 255000 of size 262144\par 09:51:31.878 [9181] <2> int_WriteData: INF - writing buffer # 256000 of size 262144\par 09:51:38.918 [9181] <2> int_WriteData: INF - writing buffer # 257000 of size 262144\par 09:51:44.773 [9181] <2> int_WriteData: INF - writing buffer # 258000 of size 262144\par 09:51:49.131 [9181] <2> int_CloseImage: INF - Backup - closing \par 09:51:49.132 [9181] <4> CleanUpShM: INF - dbclient waited 11548 times for empty buffer, delayed 11779 times\par 09:52:00.199 [9181] <2> int_logDateRange: INF - Start Time = 02/27/12 18:32:31\par 09:52:00.199 [9181] <2> int_logDateRange: INF - End Time = 02/29/12 18:32:31\par 09:52:00.202 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:52:00.202 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 09:52:00.213 [9181] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 09:52:00.213 [9181] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44625 TO 25.1.1.131.1556 fd = 17\par 09:52:01.171 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 09:52:01.171 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 09:52:01.171 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 09:52:01.171 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 09:52:01.171 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 09:52:01.171 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 09:52:01.171 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 09:52:01.171 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 1672\par 09:52:01.173 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:52:01.173 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+1672,1,4,2,2,0+bmmi-db-prsrv2.txt\par 09:52:01.174 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 09:52:01.174 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 09:52:01.174 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 09:52:01.174 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 09:52:01.174 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 09:52:01.174 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 09:52:01.174 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 09:52:01.174 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3442\par 09:52:01.174 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:52:01.174 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3442,1,4,2,2,0+bmmi-db-prsrv2.txt\par 09:52:01.175 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 09:52:01.175 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 09:52:01.175 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 09:52:01.175 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 09:52:01.175 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 09:52:01.175 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 09:52:01.175 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 09:52:01.175 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3928\par 09:52:01.175 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 09:52:01.175 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3928,1,4,2,2,0+bmmi-db-prsrv2.txt\par 09:52:07.848 [9181] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 09:52:07.854 [9181] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 09:52:07.854 [9181] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44650 TO 25.1.1.131.1556 fd = 18\par 09:52:12.228 [9182] <2> int_StartJob: INF - copyID: 1 - 1330411439\par \par 09:52:12.290 [9182] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 09:52:15.653 [9182] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 09:52:19.145 [9182] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 09:52:22.405 [9182] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 09:52:26.013 [9182] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 09:52:29.473 [9182] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 09:52:34.337 [9182] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 09:52:37.898 [9182] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 09:52:41.330 [9182] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 09:52:44.902 [9182] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 09:52:48.163 [9182] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 09:52:51.695 [9182] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 09:52:55.126 [9182] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 09:52:58.564 [9182] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 09:53:01.995 [9182] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 09:53:05.361 [9182] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 09:53:08.716 [9182] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 09:53:11.846 [9182] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 09:53:15.276 [9182] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 09:53:18.821 [9182] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 09:53:22.544 [9182] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 09:53:26.279 [9182] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 09:53:29.927 [9182] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 09:53:33.422 [9182] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 09:53:37.154 [9182] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 09:53:40.616 [9182] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 09:53:44.160 [9182] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 09:53:47.418 [9182] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 09:53:50.957 [9182] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 09:53:54.291 [9182] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 09:53:57.788 [9182] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 09:54:01.523 [9182] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 09:54:04.934 [9182] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 09:54:08.551 [9182] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 09:54:12.381 [9182] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 09:54:15.922 [9182] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 09:54:19.519 [9182] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 09:54:23.048 [9182] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 09:54:26.645 [9182] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 09:54:30.171 [9182] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 09:54:33.542 [9182] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 09:54:37.179 [9182] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 09:54:40.926 [9182] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 09:54:44.523 [9182] <2> int_WriteData: INF - writing buffer # 43000 of size 262144\par 09:54:48.088 [9182] <2> int_WriteData: INF - writing buffer # 44000 of size 262144\par 09:54:51.677 [9182] <2> int_WriteData: INF - writing buffer # 45000 of size 262144\par 09:54:55.490 [9182] <2> int_WriteData: INF - writing buffer # 46000 of size 262144\par 09:54:59.863 [9182] <2> int_WriteData: INF - writing buffer # 47000 of size 262144\par 09:55:03.498 [9182] <2> int_WriteData: INF - writing buffer # 48000 of size 262144\par 09:55:07.191 [9182] <2> int_WriteData: INF - writing buffer # 49000 of size 262144\par 09:55:11.228 [9182] <2> int_WriteData: INF - writing buffer # 50000 of size 262144\par 09:55:14.779 [9182] <2> int_WriteData: INF - writing buffer # 51000 of size 262144\par 09:55:18.279 [9182] <2> int_WriteData: INF - writing buffer # 52000 of size 262144\par 09:55:21.833 [9182] <2> int_WriteData: INF - writing buffer # 53000 of size 262144\par 09:55:25.500 [9182] <2> int_WriteData: INF - writing buffer # 54000 of size 262144\par 09:55:29.117 [9182] <2> int_WriteData: INF - writing buffer # 55000 of size 262144\par 09:55:32.808 [9182] <2> int_WriteData: INF - writing buffer # 56000 of size 262144\par 09:55:36.499 [9182] <2> int_WriteData: INF - writing buffer # 57000 of size 262144\par 09:55:40.033 [9182] <2> int_WriteData: INF - writing buffer # 58000 of size 262144\par 09:55:43.940 [9182] <2> int_WriteData: INF - writing buffer # 59000 of size 262144\par 09:55:47.969 [9182] <2> int_WriteData: INF - writing buffer # 60000 of size 262144\par 09:55:52.043 [9182] <2> int_WriteData: INF - writing buffer # 61000 of size 262144\par 09:55:56.186 [9182] <2> int_WriteData: INF - writing buffer # 62000 of size 262144\par 09:56:00.747 [9182] <2> int_WriteData: INF - writing buffer # 63000 of size 262144\par 09:56:05.435 [9182] <2> int_WriteData: INF - writing buffer # 64000 of size 262144\par 09:56:10.031 [9182] <2> int_WriteData: INF - writing buffer # 65000 of size 262144\par 09:56:14.208 [9182] <2> int_WriteData: INF - writing buffer # 66000 of size 262144\par 09:56:18.227 [9182] <2> int_WriteData: INF - writing buffer # 67000 of size 262144\par 09:56:22.525 [9182] <2> int_WriteData: INF - writing buffer # 68000 of size 262144\par 09:56:27.298 [9182] <2> int_WriteData: INF - writing buffer # 69000 of size 262144\par 09:56:32.526 [9182] <2> int_WriteData: INF - writing buffer # 70000 of size 262144\par 09:56:37.350 [9182] <2> int_WriteData: INF - writing buffer # 71000 of size 262144\par 09:56:42.704 [9182] <2> int_WriteData: INF - writing buffer # 72000 of size 262144\par 09:56:47.739 [9182] <2> int_WriteData: INF - writing buffer # 73000 of size 262144\par 09:56:53.261 [9182] <2> int_WriteData: INF - writing buffer # 74000 of size 262144\par 09:56:59.647 [9182] <2> int_WriteData: INF - writing buffer # 75000 of size 262144\par 09:57:05.330 [9182] <2> int_WriteData: INF - writing buffer # 76000 of size 262144\par 09:57:10.617 [9182] <2> int_WriteData: INF - writing buffer # 77000 of size 262144\par 09:57:16.375 [9182] <2> int_WriteData: INF - writing buffer # 78000 of size 262144\par 09:57:20.681 [9182] <2> int_WriteData: INF - writing buffer # 79000 of size 262144\par 09:57:25.268 [9182] <2> int_WriteData: INF - writing buffer # 80000 of size 262144\par 09:57:30.183 [9182] <2> int_WriteData: INF - writing buffer # 81000 of size 262144\par 09:57:35.236 [9182] <2> int_WriteData: INF - writing buffer # 82000 of size 262144\par 09:57:40.402 [9182] <2> int_WriteData: INF - writing buffer # 83000 of size 262144\par 09:57:46.890 [9182] <2> int_WriteData: INF - writing buffer # 84000 of size 262144\par 09:57:52.862 [9182] <2> int_WriteData: INF - writing buffer # 85000 of size 262144\par 09:57:59.158 [9182] <2> int_WriteData: INF - writing buffer # 86000 of size 262144\par 09:58:04.851 [9182] <2> int_WriteData: INF - writing buffer # 87000 of size 262144\par 09:58:10.528 [9182] <2> int_WriteData: INF - writing buffer # 88000 of size 262144\par 09:58:15.912 [9182] <2> int_WriteData: INF - writing buffer # 89000 of size 262144\par 09:58:20.653 [9182] <2> int_WriteData: INF - writing buffer # 90000 of size 262144\par 09:58:25.949 [9182] <2> int_WriteData: INF - writing buffer # 91000 of size 262144\par 09:58:31.163 [9182] <2> int_WriteData: INF - writing buffer # 92000 of size 262144\par 09:58:36.289 [9182] <2> int_WriteData: INF - writing buffer # 93000 of size 262144\par 09:58:41.329 [9182] <2> int_WriteData: INF - writing buffer # 94000 of size 262144\par 09:58:46.991 [9182] <2> int_WriteData: INF - writing buffer # 95000 of size 262144\par 09:58:52.321 [9182] <2> int_WriteData: INF - writing buffer # 96000 of size 262144\par 09:58:57.557 [9182] <2> int_WriteData: INF - writing buffer # 97000 of size 262144\par 09:59:03.251 [9182] <2> int_WriteData: INF - writing buffer # 98000 of size 262144\par 09:59:09.199 [9182] <2> int_WriteData: INF - writing buffer # 99000 of size 262144\par 09:59:14.607 [9182] <2> int_WriteData: INF - writing buffer # 100000 of size 262144\par 09:59:20.689 [9182] <2> int_WriteData: INF - writing buffer # 101000 of size 262144\par 09:59:26.584 [9182] <2> int_WriteData: INF - writing buffer # 102000 of size 262144\par 09:59:32.628 [9182] <2> int_WriteData: INF - writing buffer # 103000 of size 262144\par 09:59:38.171 [9182] <2> int_WriteData: INF - writing buffer # 104000 of size 262144\par 09:59:43.820 [9182] <2> int_WriteData: INF - writing buffer # 105000 of size 262144\par 09:59:48.949 [9182] <2> int_WriteData: INF - writing buffer # 106000 of size 262144\par 09:59:54.887 [9182] <2> int_WriteData: INF - writing buffer # 107000 of size 262144\par 10:00:00.944 [9182] <2> int_WriteData: INF - writing buffer # 108000 of size 262144\par 10:00:06.829 [9182] <2> int_WriteData: INF - writing buffer # 109000 of size 262144\par 10:00:11.639 [9182] <2> int_WriteData: INF - writing buffer # 110000 of size 262144\par 10:00:16.854 [9182] <2> int_WriteData: INF - writing buffer # 111000 of size 262144\par 10:00:21.839 [9182] <2> int_WriteData: INF - writing buffer # 112000 of size 262144\par 10:00:26.687 [9182] <2> int_WriteData: INF - writing buffer # 113000 of size 262144\par 10:00:31.242 [9182] <2> int_WriteData: INF - writing buffer # 114000 of size 262144\par 10:00:36.355 [9182] <2> int_WriteData: INF - writing buffer # 115000 of size 262144\par 10:00:41.452 [9182] <2> int_WriteData: INF - writing buffer # 116000 of size 262144\par 10:00:45.791 [9182] <2> int_WriteData: INF - writing buffer # 117000 of size 262144\par 10:00:50.372 [9182] <2> int_WriteData: INF - writing buffer # 118000 of size 262144\par 10:00:55.248 [9182] <2> int_WriteData: INF - writing buffer # 119000 of size 262144\par 10:00:59.449 [9182] <2> int_WriteData: INF - writing buffer # 120000 of size 262144\par 10:01:03.494 [9182] <2> int_WriteData: INF - writing buffer # 121000 of size 262144\par 10:01:07.480 [9182] <2> int_WriteData: INF - writing buffer # 122000 of size 262144\par 10:01:11.916 [9182] <2> int_WriteData: INF - writing buffer # 123000 of size 262144\par 10:01:16.277 [9182] <2> int_WriteData: INF - writing buffer # 124000 of size 262144\par 10:02:34.205 [9182] <2> int_CloseImage: INF - Backup - closing \par 10:02:34.205 [9182] <4> CleanUpShM: INF - dbclient waited 4909 times for empty buffer, delayed 4979 times\par 10:02:44.280 [9182] <2> int_logDateRange: INF - Start Time = 02/27/12 18:32:31\par 10:02:44.280 [9182] <2> int_logDateRange: INF - End Time = 02/29/12 18:32:31\par 10:02:44.282 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:02:44.282 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:02:44.285 [9182] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:02:44.286 [9182] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44798 TO 25.1.1.131.1556 fd = 17\par 10:02:46.247 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:02:46.247 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:02:46.247 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:02:46.247 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:02:46.247 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:02:46.247 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:02:46.247 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:02:46.247 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4950\par 10:02:46.248 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:02:46.248 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4950,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:02:46.249 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:02:46.249 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:02:46.249 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:02:46.249 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:02:46.249 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:02:46.249 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:02:46.249 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:02:46.249 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3318\par 10:02:46.249 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:02:46.249 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3318,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:02:47.260 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:02:47.260 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:02:47.260 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:02:47.260 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:02:47.260 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:02:47.260 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:02:47.260 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:02:47.260 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4052\par 10:02:47.260 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:02:47.260 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4052,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:02:53.580 [9182] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:02:53.585 [9182] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:02:53.585 [9182] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44828 TO 25.1.1.131.1556 fd = 18\par 10:02:58.320 [9181] <2> int_StartJob: INF - copyID: 1 - 1330412084\par \par 10:02:58.380 [9181] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:03:02.255 [9181] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 10:03:05.791 [9181] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 10:03:12.440 [9181] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 10:03:18.473 [9181] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 10:03:24.714 [9181] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 10:03:29.208 [9181] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 10:03:33.736 [9181] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 10:03:38.662 [9181] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 10:03:43.209 [9181] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 10:03:48.473 [9181] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 10:03:53.090 [9181] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 10:03:57.230 [9181] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 10:04:00.990 [9181] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 10:04:04.755 [9181] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 10:04:09.364 [9181] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 10:04:13.400 [9181] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 10:04:17.548 [9181] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 10:04:21.530 [9181] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 10:04:25.579 [9181] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 10:04:29.892 [9181] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 10:04:34.582 [9181] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 10:04:39.505 [9181] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 10:04:45.057 [9181] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 10:04:51.029 [9181] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 10:04:56.548 [9181] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 10:05:01.881 [9181] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 10:05:07.107 [9181] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 10:05:11.528 [9181] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 10:05:15.607 [9181] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 10:05:19.640 [9181] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 10:05:24.135 [9181] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 10:05:29.302 [9181] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 10:05:34.694 [9181] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 10:05:40.124 [9181] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 10:05:45.195 [9181] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 10:05:50.405 [9181] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 10:05:54.740 [9181] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 10:05:59.237 [9181] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 10:06:03.976 [9181] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 10:06:08.705 [9181] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 10:06:13.288 [9181] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 10:06:18.600 [9181] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 10:06:24.061 [9181] <2> int_WriteData: INF - writing buffer # 43000 of size 262144\par 10:06:30.082 [9181] <2> int_WriteData: INF - writing buffer # 44000 of size 262144\par 10:06:37.782 [9181] <2> int_CloseImage: INF - Backup - closing \par 10:06:37.783 [9181] <4> CleanUpShM: INF - dbclient waited 1412 times for empty buffer, delayed 1432 times\par 10:06:48.873 [9181] <2> int_logDateRange: INF - Start Time = 02/27/12 18:52:07\par 10:06:48.873 [9181] <2> int_logDateRange: INF - End Time = 02/29/12 18:52:07\par 10:06:48.876 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:06:48.876 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:06:48.878 [9181] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:06:48.878 [9181] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44887 TO 25.1.1.131.1556 fd = 17\par 10:06:50.205 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:06:50.205 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:06:50.205 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:06:50.205 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:06:50.205 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:06:50.205 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:06:50.205 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:06:50.205 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3926\par 10:06:50.206 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:06:50.206 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3926,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:06:50.213 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:06:50.213 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:06:50.213 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:06:50.213 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:06:50.213 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:06:50.213 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:06:50.213 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:06:50.213 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3806\par 10:06:50.213 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:06:50.213 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3806,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:06:50.214 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:06:50.214 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:06:50.214 [9182] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:06:50.214 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:06:50.214 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:06:50.214 [9182] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:06:50.214 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:06:50.214 [9182] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 2404\par 10:06:50.214 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:06:50.214 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+2404,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:06:59.441 [9181] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:06:59.449 [9181] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:06:59.450 [9181] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44916 TO 25.1.1.131.1556 fd = 18\par 10:07:01.263 [9182] <2> int_StartJob: INF - copyID: 1 - 1330412328\par \par 10:07:01.349 [9182] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:07:05.328 [9182] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 10:07:09.167 [9182] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 10:07:13.101 [9182] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 10:07:16.947 [9182] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 10:07:21.216 [9182] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 10:07:25.286 [9182] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 10:07:29.098 [9182] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 10:07:33.115 [9182] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 10:07:37.205 [9182] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 10:07:41.716 [9182] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 10:07:46.089 [9182] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 10:07:50.172 [9182] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 10:07:54.181 [9182] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 10:07:57.915 [9182] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 10:08:01.995 [9182] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 10:08:05.998 [9182] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 10:08:10.045 [9182] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 10:08:14.288 [9182] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 10:08:18.374 [9182] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 10:08:22.575 [9182] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 10:08:26.836 [9182] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 10:08:30.776 [9182] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 10:08:34.801 [9182] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 10:08:38.989 [9182] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 10:08:43.172 [9182] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 10:08:47.194 [9182] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 10:08:51.284 [9182] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 10:08:55.088 [9182] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 10:08:58.790 [9182] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 10:09:02.381 [9182] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 10:09:06.717 [9182] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 10:09:11.247 [9182] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 10:09:15.257 [9182] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 10:09:19.045 [9182] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 10:09:22.917 [9182] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 10:09:26.825 [9182] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 10:09:31.112 [9182] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 10:09:35.646 [9182] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 10:09:39.891 [9182] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 10:09:44.324 [9182] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 10:09:48.785 [9182] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 10:09:52.948 [9182] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 10:10:04.890 [9182] <2> int_CloseImage: INF - Backup - closing \par 10:10:04.890 [9182] <4> CleanUpShM: INF - dbclient waited 2433 times for empty buffer, delayed 2433 times\par 10:10:14.935 [9182] <2> int_logDateRange: INF - Start Time = 02/27/12 19:02:53\par 10:10:14.936 [9182] <2> int_logDateRange: INF - End Time = 02/29/12 19:02:53\par 10:10:14.938 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:10:14.938 [9182] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:10:14.940 [9182] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:10:14.941 [9182] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.44966 TO 25.1.1.131.1556 fd = 17\par 10:10:17.797 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:10:17.797 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:10:17.797 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:10:17.797 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:10:17.797 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:10:17.797 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:10:17.797 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:10:17.797 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4188\par 10:10:17.798 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:10:17.798 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4188,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:10:17.799 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:10:17.799 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:10:17.799 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:10:17.799 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:10:17.799 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:10:17.799 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:10:17.799 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:10:17.799 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3866\par 10:10:17.799 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:10:17.799 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3866,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:10:17.800 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:10:17.800 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:10:17.800 [9181] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:10:17.800 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:10:17.800 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:10:17.800 [9181] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:10:17.800 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:10:17.800 [9181] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 1280\par 10:10:17.800 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:10:17.800 [9181] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+1280,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:10:28.866 [9181] <2> int_StartJob: INF - copyID: 1 - 1330412535\par \par 10:10:28.877 [9181] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:10:29.045 [9181] <2> int_CloseImage: INF - Backup - closing \par 10:10:29.046 [9181] <4> CleanUpShM: INF - dbclient waited 2 times for empty buffer, delayed 2 times\par 10:10:39.126 [9181] <2> int_logDateRange: INF - Start Time = 02/27/12 19:06:58\par 10:10:39.126 [9181] <2> int_logDateRange: INF - End Time = 02/29/12 19:06:58\par 10:10:39.133 [9181] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:10:39.133 [9181] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45002 TO 25.1.1.131.1556 fd = 17\par 10:10:44.144 [9181] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:10:44.144 [9181] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:10:44.144 [9181] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:10:44.151 [9181] <4> sbtend: INF - --- END of SESSION ---\par 10:10:44.283 [9182] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:10:44.283 [9182] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:10:44.283 [9182] <4> sbtend: INF - --- END of SESSION ---\par 10:10:44.433 [9181] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:10:44.433 [9181] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:10:44.433 [9181] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:10:44.433 [9181] <2> int_GetMMInfo: INF - Initialized Signal\par 10:10:44.433 [9181] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:10:44.584 [9182] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:10:44.584 [9182] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:10:44.584 [9182] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:10:44.584 [9182] <2> int_GetMMInfo: INF - Initialized Signal\par 10:10:44.584 [9182] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:10:45.892 [9181] <4> sbtend: INF - --- END of SESSION ---\par 10:10:45.901 [9182] <4> sbtend: INF - --- END of SESSION ---\par 10:15:50.545 [11164] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:15:50.545 [11164] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:15:50.545 [11164] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:15:50.545 [11164] <2> int_GetMMInfo: INF - Initialized Signal\par 10:15:50.546 [11164] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:15:51.088 [11171] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:15:51.088 [11171] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:15:51.088 [11171] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:15:51.088 [11171] <2> int_GetMMInfo: INF - Initialized Signal\par 10:15:51.088 [11171] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:15:52.166 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:15:52.166 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:15:52.166 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:15:52.166 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:15:52.173 [11171] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:15:52.173 [11171] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45102 TO 25.1.1.131.1556 fd = 17\par 10:15:52.174 [11164] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:15:52.174 [11164] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45103 TO 25.1.1.131.1556 fd = 17\par 10:15:52.211 [11171] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:15:52.223 [11171] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:15:52.223 [11171] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45104 TO 25.1.1.131.1556 fd = 18\par 10:15:52.227 [11164] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:15:52.233 [11164] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:15:52.233 [11164] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45105 TO 25.1.1.131.1556 fd = 18\par 10:16:01.293 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:16:01.293 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:16:01.298 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:16:01.298 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:16:01.298 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:16:01.298 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:16:01.299 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:16:01.299 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 2780\par 10:16:01.299 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:16:01.299 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+2780,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:16:01.300 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:16:01.300 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:16:01.300 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:16:01.300 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:16:01.300 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:16:01.300 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:16:01.300 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:16:01.300 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4026\par 10:16:01.300 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:16:01.300 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4026,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:16:01.301 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:16:01.301 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:16:01.301 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:16:01.301 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:16:01.301 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:16:01.301 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:16:01.301 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:16:01.301 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3568\par 10:16:01.301 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:16:01.301 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3568,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:17:50.953 [11171] <2> int_StartJob: INF - copyID: 1 - 1330412879\par \par 10:17:50.959 [11171] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:17:54.086 [11171] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 10:17:57.134 [11171] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 10:18:00.063 [11171] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 10:18:03.630 [11171] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 10:18:07.203 [11171] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 10:18:10.648 [11171] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 10:18:14.440 [11171] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 10:18:18.208 [11171] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 10:18:21.938 [11171] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 10:18:25.537 [11171] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 10:18:29.198 [11171] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 10:18:32.750 [11171] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 10:18:36.406 [11171] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 10:18:40.066 [11171] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 10:18:43.850 [11171] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 10:18:47.498 [11171] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 10:18:51.151 [11171] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 10:18:54.768 [11171] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 10:18:58.212 [11171] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 10:19:01.635 [11171] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 10:19:05.078 [11171] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 10:19:08.682 [11171] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 10:19:13.346 [11171] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 10:19:17.029 [11171] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 10:19:20.532 [11171] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 10:19:24.115 [11171] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 10:19:28.064 [11171] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 10:19:31.842 [11171] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 10:19:35.765 [11171] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 10:19:39.627 [11171] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 10:19:43.362 [11171] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 10:19:47.529 [11171] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 10:19:51.520 [11171] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 10:19:55.306 [11171] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 10:19:58.894 [11171] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 10:20:02.641 [11171] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 10:20:06.139 [11171] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 10:20:09.798 [11171] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 10:20:13.605 [11171] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 10:20:17.459 [11171] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 10:20:21.406 [11171] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 10:20:25.265 [11171] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 10:20:28.886 [11171] <2> int_WriteData: INF - writing buffer # 43000 of size 262144\par 10:20:32.578 [11171] <2> int_WriteData: INF - writing buffer # 44000 of size 262144\par 10:20:36.498 [11171] <2> int_WriteData: INF - writing buffer # 45000 of size 262144\par 10:20:40.186 [11171] <2> int_WriteData: INF - writing buffer # 46000 of size 262144\par 10:20:43.938 [11171] <2> int_WriteData: INF - writing buffer # 47000 of size 262144\par 10:20:47.726 [11171] <2> int_WriteData: INF - writing buffer # 48000 of size 262144\par 10:20:51.739 [11171] <2> int_WriteData: INF - writing buffer # 49000 of size 262144\par 10:20:55.620 [11171] <2> int_WriteData: INF - writing buffer # 50000 of size 262144\par 10:20:59.518 [11171] <2> int_WriteData: INF - writing buffer # 51000 of size 262144\par 10:21:03.455 [11171] <2> int_WriteData: INF - writing buffer # 52000 of size 262144\par 10:21:07.461 [11171] <2> int_WriteData: INF - writing buffer # 53000 of size 262144\par 10:21:11.507 [11171] <2> int_WriteData: INF - writing buffer # 54000 of size 262144\par 10:21:15.618 [11171] <2> int_WriteData: INF - writing buffer # 55000 of size 262144\par 10:21:19.311 [11171] <2> int_WriteData: INF - writing buffer # 56000 of size 262144\par 10:21:23.301 [11171] <2> int_WriteData: INF - writing buffer # 57000 of size 262144\par 10:21:27.407 [11171] <2> int_WriteData: INF - writing buffer # 58000 of size 262144\par 10:21:31.493 [11171] <2> int_WriteData: INF - writing buffer # 59000 of size 262144\par 10:21:37.200 [11171] <2> int_WriteData: INF - writing buffer # 60000 of size 262144\par 10:21:43.042 [11171] <2> int_WriteData: INF - writing buffer # 61000 of size 262144\par 10:21:48.895 [11171] <2> int_WriteData: INF - writing buffer # 62000 of size 262144\par 10:21:54.567 [11171] <2> int_WriteData: INF - writing buffer # 63000 of size 262144\par 10:22:00.243 [11171] <2> int_WriteData: INF - writing buffer # 64000 of size 262144\par 10:22:05.951 [11171] <2> int_WriteData: INF - writing buffer # 65000 of size 262144\par 10:22:11.503 [11171] <2> int_WriteData: INF - writing buffer # 66000 of size 262144\par 10:22:16.564 [11171] <2> int_WriteData: INF - writing buffer # 67000 of size 262144\par 10:22:21.639 [11171] <2> int_WriteData: INF - writing buffer # 68000 of size 262144\par 10:22:26.874 [11171] <2> int_WriteData: INF - writing buffer # 69000 of size 262144\par 10:22:32.286 [11171] <2> int_WriteData: INF - writing buffer # 70000 of size 262144\par 10:22:37.460 [11171] <2> int_WriteData: INF - writing buffer # 71000 of size 262144\par 10:22:43.055 [11171] <2> int_WriteData: INF - writing buffer # 72000 of size 262144\par 10:22:48.025 [11171] <2> int_WriteData: INF - writing buffer # 73000 of size 262144\par 10:22:53.190 [11171] <2> int_WriteData: INF - writing buffer # 74000 of size 262144\par 10:22:58.344 [11171] <2> int_WriteData: INF - writing buffer # 75000 of size 262144\par 10:23:03.664 [11171] <2> int_WriteData: INF - writing buffer # 76000 of size 262144\par 10:23:09.058 [11171] <2> int_WriteData: INF - writing buffer # 77000 of size 262144\par 10:23:14.336 [11171] <2> int_WriteData: INF - writing buffer # 78000 of size 262144\par 10:23:19.189 [11171] <2> int_WriteData: INF - writing buffer # 79000 of size 262144\par 10:23:23.887 [11171] <2> int_WriteData: INF - writing buffer # 80000 of size 262144\par 10:23:28.591 [11171] <2> int_WriteData: INF - writing buffer # 81000 of size 262144\par 10:23:33.097 [11171] <2> int_WriteData: INF - writing buffer # 82000 of size 262144\par 10:23:37.795 [11171] <2> int_WriteData: INF - writing buffer # 83000 of size 262144\par 10:23:42.526 [11171] <2> int_WriteData: INF - writing buffer # 84000 of size 262144\par 10:23:47.224 [11171] <2> int_WriteData: INF - writing buffer # 85000 of size 262144\par 10:23:52.289 [11171] <2> int_WriteData: INF - writing buffer # 86000 of size 262144\par 10:23:56.986 [11171] <2> int_WriteData: INF - writing buffer # 87000 of size 262144\par 10:24:02.236 [11171] <2> int_WriteData: INF - writing buffer # 88000 of size 262144\par 10:24:07.384 [11171] <2> int_WriteData: INF - writing buffer # 89000 of size 262144\par 10:24:12.095 [11171] <2> int_WriteData: INF - writing buffer # 90000 of size 262144\par 10:24:17.062 [11171] <2> int_WriteData: INF - writing buffer # 91000 of size 262144\par 10:24:22.519 [11171] <2> int_WriteData: INF - writing buffer # 92000 of size 262144\par 10:24:28.062 [11171] <2> int_WriteData: INF - writing buffer # 93000 of size 262144\par 10:24:33.193 [11171] <2> int_WriteData: INF - writing buffer # 94000 of size 262144\par 10:24:38.288 [11171] <2> int_WriteData: INF - writing buffer # 95000 of size 262144\par 10:24:43.719 [11171] <2> int_WriteData: INF - writing buffer # 96000 of size 262144\par 10:24:48.516 [11171] <2> int_WriteData: INF - writing buffer # 97000 of size 262144\par 10:24:53.489 [11171] <2> int_WriteData: INF - writing buffer # 98000 of size 262144\par 10:24:58.055 [11171] <2> int_WriteData: INF - writing buffer # 99000 of size 262144\par 10:25:02.704 [11171] <2> int_WriteData: INF - writing buffer # 100000 of size 262144\par 10:25:07.735 [11171] <2> int_WriteData: INF - writing buffer # 101000 of size 262144\par 10:25:12.691 [11171] <2> int_WriteData: INF - writing buffer # 102000 of size 262144\par 10:25:17.223 [11171] <2> int_WriteData: INF - writing buffer # 103000 of size 262144\par 10:25:22.206 [11171] <2> int_WriteData: INF - writing buffer # 104000 of size 262144\par 10:25:27.490 [11171] <2> int_WriteData: INF - writing buffer # 105000 of size 262144\par 10:25:32.500 [11171] <2> int_WriteData: INF - writing buffer # 106000 of size 262144\par 10:25:37.756 [11171] <2> int_WriteData: INF - writing buffer # 107000 of size 262144\par 10:25:42.983 [11171] <2> int_WriteData: INF - writing buffer # 108000 of size 262144\par 10:25:47.800 [11171] <2> int_WriteData: INF - writing buffer # 109000 of size 262144\par 10:25:52.677 [11171] <2> int_WriteData: INF - writing buffer # 110000 of size 262144\par 10:25:57.865 [11171] <2> int_WriteData: INF - writing buffer # 111000 of size 262144\par 10:26:02.514 [11171] <2> int_WriteData: INF - writing buffer # 112000 of size 262144\par 10:26:07.192 [11171] <2> int_WriteData: INF - writing buffer # 113000 of size 262144\par 10:26:12.075 [11171] <2> int_WriteData: INF - writing buffer # 114000 of size 262144\par 10:26:16.841 [11171] <2> int_WriteData: INF - writing buffer # 115000 of size 262144\par 10:26:21.646 [11171] <2> int_WriteData: INF - writing buffer # 116000 of size 262144\par 10:26:26.284 [11171] <2> int_WriteData: INF - writing buffer # 117000 of size 262144\par 10:26:30.905 [11171] <2> int_WriteData: INF - writing buffer # 118000 of size 262144\par 10:26:35.701 [11171] <2> int_WriteData: INF - writing buffer # 119000 of size 262144\par 10:26:40.684 [11171] <2> int_WriteData: INF - writing buffer # 120000 of size 262144\par 10:26:45.569 [11171] <2> int_WriteData: INF - writing buffer # 121000 of size 262144\par 10:26:50.333 [11171] <2> int_WriteData: INF - writing buffer # 122000 of size 262144\par 10:26:55.081 [11171] <2> int_WriteData: INF - writing buffer # 123000 of size 262144\par 10:27:00.613 [11171] <2> int_WriteData: INF - writing buffer # 124000 of size 262144\par 10:28:37.039 [11171] <2> int_CloseImage: INF - Backup - closing \par 10:28:37.039 [11171] <4> CleanUpShM: INF - dbclient waited 4942 times for empty buffer, delayed 4987 times\par 10:28:48.102 [11171] <2> int_logDateRange: INF - Start Time = 02/27/12 19:15:52\par 10:28:48.102 [11171] <2> int_logDateRange: INF - End Time = 02/29/12 19:15:52\par 10:28:48.105 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:28:48.105 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:28:48.110 [11171] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:28:48.110 [11171] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45307 TO 25.1.1.131.1556 fd = 17\par 10:28:49.734 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:28:49.734 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:28:49.734 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:28:49.734 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:28:49.734 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:28:49.734 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:28:49.734 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:28:49.734 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4644\par 10:28:49.735 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:28:49.735 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4644,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:28:49.737 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:28:49.737 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:28:49.737 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:28:49.737 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:28:49.737 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:28:49.737 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:28:49.737 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:28:49.737 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4330\par 10:28:49.737 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:28:49.737 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4330,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:28:49.738 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:28:49.738 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:28:49.738 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:28:49.738 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:28:49.738 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:28:49.738 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:28:49.738 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:28:49.738 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 2672\par 10:28:49.739 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:28:49.739 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+2672,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:28:58.068 [11171] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:28:58.080 [11171] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:28:58.080 [11171] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45334 TO 25.1.1.131.1556 fd = 18\par 10:29:00.792 [11164] <2> int_StartJob: INF - copyID: 1 - 1330413647\par \par 10:29:00.829 [11164] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:29:04.495 [11164] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 10:29:07.936 [11164] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 10:29:11.131 [11164] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 10:29:14.432 [11164] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 10:29:18.093 [11164] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 10:29:21.558 [11164] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 10:29:25.072 [11164] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 10:29:28.368 [11164] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 10:29:31.570 [11164] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 10:29:35.171 [11164] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 10:29:38.763 [11164] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 10:29:42.190 [11164] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 10:29:45.784 [11164] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 10:29:49.474 [11164] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 10:29:52.970 [11164] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 10:29:56.372 [11164] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 10:29:59.708 [11164] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 10:30:03.404 [11164] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 10:30:07.032 [11164] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 10:30:10.538 [11164] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 10:30:14.099 [11164] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 10:30:18.225 [11164] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 10:30:21.850 [11164] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 10:30:25.475 [11164] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 10:30:29.106 [11164] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 10:30:32.675 [11164] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 10:30:36.459 [11164] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 10:30:40.144 [11164] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 10:30:44.122 [11164] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 10:30:47.876 [11164] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 10:30:51.342 [11164] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 10:30:54.888 [11164] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 10:30:58.713 [11164] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 10:31:02.520 [11164] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 10:31:06.320 [11164] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 10:31:10.057 [11164] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 10:31:14.115 [11164] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 10:31:17.732 [11164] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 10:31:21.508 [11164] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 10:31:25.294 [11164] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 10:31:29.136 [11164] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 10:31:32.940 [11164] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 10:31:36.760 [11164] <2> int_WriteData: INF - writing buffer # 43000 of size 262144\par 10:31:40.518 [11164] <2> int_WriteData: INF - writing buffer # 44000 of size 262144\par 10:31:44.168 [11164] <2> int_WriteData: INF - writing buffer # 45000 of size 262144\par 10:31:48.029 [11164] <2> int_WriteData: INF - writing buffer # 46000 of size 262144\par 10:31:51.976 [11164] <2> int_WriteData: INF - writing buffer # 47000 of size 262144\par 10:31:55.850 [11164] <2> int_WriteData: INF - writing buffer # 48000 of size 262144\par 10:31:59.769 [11164] <2> int_WriteData: INF - writing buffer # 49000 of size 262144\par 10:32:03.577 [11164] <2> int_WriteData: INF - writing buffer # 50000 of size 262144\par 10:32:07.425 [11164] <2> int_WriteData: INF - writing buffer # 51000 of size 262144\par 10:32:11.077 [11164] <2> int_WriteData: INF - writing buffer # 52000 of size 262144\par 10:32:14.863 [11164] <2> int_WriteData: INF - writing buffer # 53000 of size 262144\par 10:32:18.712 [11164] <2> int_WriteData: INF - writing buffer # 54000 of size 262144\par 10:32:22.499 [11164] <2> int_WriteData: INF - writing buffer # 55000 of size 262144\par 10:32:26.221 [11164] <2> int_WriteData: INF - writing buffer # 56000 of size 262144\par 10:32:29.846 [11164] <2> int_WriteData: INF - writing buffer # 57000 of size 262144\par 10:32:33.639 [11164] <2> int_WriteData: INF - writing buffer # 58000 of size 262144\par 10:32:37.639 [11164] <2> int_WriteData: INF - writing buffer # 59000 of size 262144\par 10:32:41.392 [11164] <2> int_WriteData: INF - writing buffer # 60000 of size 262144\par 10:32:45.147 [11164] <2> int_WriteData: INF - writing buffer # 61000 of size 262144\par 10:32:48.877 [11164] <2> int_WriteData: INF - writing buffer # 62000 of size 262144\par 10:32:52.469 [11164] <2> int_WriteData: INF - writing buffer # 63000 of size 262144\par 10:32:56.231 [11164] <2> int_WriteData: INF - writing buffer # 64000 of size 262144\par 10:33:00.049 [11164] <2> int_WriteData: INF - writing buffer # 65000 of size 262144\par 10:33:04.786 [11164] <2> int_WriteData: INF - writing buffer # 66000 of size 262144\par 10:33:08.530 [11164] <2> int_WriteData: INF - writing buffer # 67000 of size 262144\par 10:33:12.304 [11164] <2> int_WriteData: INF - writing buffer # 68000 of size 262144\par 10:33:16.096 [11164] <2> int_WriteData: INF - writing buffer # 69000 of size 262144\par 10:33:19.684 [11164] <2> int_WriteData: INF - writing buffer # 70000 of size 262144\par 10:33:23.166 [11164] <2> int_WriteData: INF - writing buffer # 71000 of size 262144\par 10:33:26.811 [11164] <2> int_WriteData: INF - writing buffer # 72000 of size 262144\par 10:33:30.523 [11164] <2> int_WriteData: INF - writing buffer # 73000 of size 262144\par 10:33:34.420 [11164] <2> int_WriteData: INF - writing buffer # 74000 of size 262144\par 10:33:38.169 [11164] <2> int_WriteData: INF - writing buffer # 75000 of size 262144\par 10:33:41.969 [11164] <2> int_WriteData: INF - writing buffer # 76000 of size 262144\par 10:33:45.786 [11164] <2> int_WriteData: INF - writing buffer # 77000 of size 262144\par 10:33:49.328 [11164] <2> int_WriteData: INF - writing buffer # 78000 of size 262144\par 10:33:54.040 [11164] <2> int_WriteData: INF - writing buffer # 79000 of size 262144\par 10:33:57.729 [11164] <2> int_WriteData: INF - writing buffer # 80000 of size 262144\par 10:34:01.234 [11164] <2> int_WriteData: INF - writing buffer # 81000 of size 262144\par 10:34:05.092 [11164] <2> int_WriteData: INF - writing buffer # 82000 of size 262144\par 10:34:08.810 [11164] <2> int_WriteData: INF - writing buffer # 83000 of size 262144\par 10:34:12.229 [11164] <2> int_WriteData: INF - writing buffer # 84000 of size 262144\par 10:34:15.953 [11164] <2> int_WriteData: INF - writing buffer # 85000 of size 262144\par 10:34:19.665 [11164] <2> int_WriteData: INF - writing buffer # 86000 of size 262144\par 10:34:23.447 [11164] <2> int_WriteData: INF - writing buffer # 87000 of size 262144\par 10:34:27.575 [11164] <2> int_WriteData: INF - writing buffer # 88000 of size 262144\par 10:34:31.487 [11164] <2> int_WriteData: INF - writing buffer # 89000 of size 262144\par 10:34:35.438 [11164] <2> int_WriteData: INF - writing buffer # 90000 of size 262144\par 10:34:39.068 [11164] <2> int_WriteData: INF - writing buffer # 91000 of size 262144\par 10:34:42.581 [11164] <2> int_WriteData: INF - writing buffer # 92000 of size 262144\par 10:34:46.643 [11164] <2> int_WriteData: INF - writing buffer # 93000 of size 262144\par 10:34:50.499 [11164] <2> int_WriteData: INF - writing buffer # 94000 of size 262144\par 10:34:54.480 [11164] <2> int_WriteData: INF - writing buffer # 95000 of size 262144\par 10:34:58.300 [11164] <2> int_WriteData: INF - writing buffer # 96000 of size 262144\par 10:35:02.115 [11164] <2> int_WriteData: INF - writing buffer # 97000 of size 262144\par 10:35:05.923 [11164] <2> int_WriteData: INF - writing buffer # 98000 of size 262144\par 10:35:09.794 [11164] <2> int_WriteData: INF - writing buffer # 99000 of size 262144\par 10:35:13.655 [11164] <2> int_WriteData: INF - writing buffer # 100000 of size 262144\par 10:35:17.233 [11164] <2> int_WriteData: INF - writing buffer # 101000 of size 262144\par 10:35:21.001 [11164] <2> int_WriteData: INF - writing buffer # 102000 of size 262144\par 10:35:24.678 [11164] <2> int_WriteData: INF - writing buffer # 103000 of size 262144\par 10:35:28.459 [11164] <2> int_WriteData: INF - writing buffer # 104000 of size 262144\par 10:35:32.078 [11164] <2> int_WriteData: INF - writing buffer # 105000 of size 262144\par 10:35:35.786 [11164] <2> int_WriteData: INF - writing buffer # 106000 of size 262144\par 10:35:41.690 [11164] <2> int_WriteData: INF - writing buffer # 107000 of size 262144\par 10:35:45.281 [11164] <2> int_WriteData: INF - writing buffer # 108000 of size 262144\par 10:35:48.911 [11164] <2> int_WriteData: INF - writing buffer # 109000 of size 262144\par 10:35:52.533 [11164] <2> int_WriteData: INF - writing buffer # 110000 of size 262144\par 10:35:56.305 [11164] <2> int_WriteData: INF - writing buffer # 111000 of size 262144\par 10:35:59.938 [11164] <2> int_WriteData: INF - writing buffer # 112000 of size 262144\par 10:36:03.810 [11164] <2> int_WriteData: INF - writing buffer # 113000 of size 262144\par 10:36:07.683 [11164] <2> int_WriteData: INF - writing buffer # 114000 of size 262144\par 10:36:11.500 [11164] <2> int_WriteData: INF - writing buffer # 115000 of size 262144\par 10:36:15.321 [11164] <2> int_WriteData: INF - writing buffer # 116000 of size 262144\par 10:36:18.865 [11164] <2> int_WriteData: INF - writing buffer # 117000 of size 262144\par 10:36:22.389 [11164] <2> int_WriteData: INF - writing buffer # 118000 of size 262144\par 10:36:25.981 [11164] <2> int_WriteData: INF - writing buffer # 119000 of size 262144\par 10:36:29.562 [11164] <2> int_WriteData: INF - writing buffer # 120000 of size 262144\par 10:36:33.436 [11164] <2> int_WriteData: INF - writing buffer # 121000 of size 262144\par 10:36:37.105 [11164] <2> int_WriteData: INF - writing buffer # 122000 of size 262144\par 10:36:40.908 [11164] <2> int_WriteData: INF - writing buffer # 123000 of size 262144\par 10:36:44.580 [11164] <2> int_WriteData: INF - writing buffer # 124000 of size 262144\par 10:36:48.247 [11164] <2> int_WriteData: INF - writing buffer # 125000 of size 262144\par 10:36:52.040 [11164] <2> int_WriteData: INF - writing buffer # 126000 of size 262144\par 10:36:55.875 [11164] <2> int_WriteData: INF - writing buffer # 127000 of size 262144\par 10:36:59.532 [11164] <2> int_WriteData: INF - writing buffer # 128000 of size 262144\par 10:37:03.341 [11164] <2> int_WriteData: INF - writing buffer # 129000 of size 262144\par 10:37:06.700 [11164] <2> int_WriteData: INF - writing buffer # 130000 of size 262144\par 10:37:10.297 [11164] <2> int_WriteData: INF - writing buffer # 131000 of size 262144\par 10:37:14.295 [11164] <2> int_WriteData: INF - writing buffer # 132000 of size 262144\par 10:37:17.823 [11164] <2> int_WriteData: INF - writing buffer # 133000 of size 262144\par 10:37:21.230 [11164] <2> int_WriteData: INF - writing buffer # 134000 of size 262144\par 10:37:24.764 [11164] <2> int_WriteData: INF - writing buffer # 135000 of size 262144\par 10:37:28.714 [11164] <2> int_WriteData: INF - writing buffer # 136000 of size 262144\par 10:37:32.558 [11164] <2> int_WriteData: INF - writing buffer # 137000 of size 262144\par 10:37:36.395 [11164] <2> int_WriteData: INF - writing buffer # 138000 of size 262144\par 10:37:40.875 [11164] <2> int_WriteData: INF - writing buffer # 139000 of size 262144\par 10:37:44.507 [11164] <2> int_WriteData: INF - writing buffer # 140000 of size 262144\par 10:37:48.337 [11164] <2> int_WriteData: INF - writing buffer # 141000 of size 262144\par 10:37:52.596 [11164] <2> int_WriteData: INF - writing buffer # 142000 of size 262144\par 10:37:56.765 [11164] <2> int_WriteData: INF - writing buffer # 143000 of size 262144\par 10:38:00.440 [11164] <2> int_WriteData: INF - writing buffer # 144000 of size 262144\par 10:38:04.433 [11164] <2> int_WriteData: INF - writing buffer # 145000 of size 262144\par 10:38:08.360 [11164] <2> int_WriteData: INF - writing buffer # 146000 of size 262144\par 10:38:12.143 [11164] <2> int_WriteData: INF - writing buffer # 147000 of size 262144\par 10:38:16.071 [11164] <2> int_WriteData: INF - writing buffer # 148000 of size 262144\par 10:38:19.744 [11164] <2> int_WriteData: INF - writing buffer # 149000 of size 262144\par 10:38:23.479 [11164] <2> int_WriteData: INF - writing buffer # 150000 of size 262144\par 10:38:27.260 [11164] <2> int_WriteData: INF - writing buffer # 151000 of size 262144\par 10:38:31.358 [11164] <2> int_WriteData: INF - writing buffer # 152000 of size 262144\par 10:38:35.282 [11164] <2> int_WriteData: INF - writing buffer # 153000 of size 262144\par 10:38:38.866 [11164] <2> int_WriteData: INF - writing buffer # 154000 of size 262144\par 10:38:42.604 [11164] <2> int_WriteData: INF - writing buffer # 155000 of size 262144\par 10:38:46.409 [11164] <2> int_WriteData: INF - writing buffer # 156000 of size 262144\par 10:38:50.236 [11164] <2> int_WriteData: INF - writing buffer # 157000 of size 262144\par 10:38:53.922 [11164] <2> int_WriteData: INF - writing buffer # 158000 of size 262144\par 10:38:57.814 [11164] <2> int_WriteData: INF - writing buffer # 159000 of size 262144\par 10:39:01.439 [11164] <2> int_WriteData: INF - writing buffer # 160000 of size 262144\par 10:39:04.894 [11164] <2> int_WriteData: INF - writing buffer # 161000 of size 262144\par 10:39:08.777 [11164] <2> int_WriteData: INF - writing buffer # 162000 of size 262144\par 10:39:12.544 [11164] <2> int_WriteData: INF - writing buffer # 163000 of size 262144\par 10:39:16.977 [11164] <2> int_WriteData: INF - writing buffer # 164000 of size 262144\par 10:39:20.953 [11164] <2> int_WriteData: INF - writing buffer # 165000 of size 262144\par 10:39:24.569 [11164] <2> int_WriteData: INF - writing buffer # 166000 of size 262144\par 10:39:28.128 [11164] <2> int_WriteData: INF - writing buffer # 167000 of size 262144\par 10:39:31.969 [11164] <2> int_WriteData: INF - writing buffer # 168000 of size 262144\par 10:39:35.997 [11164] <2> int_WriteData: INF - writing buffer # 169000 of size 262144\par 10:39:39.928 [11164] <2> int_WriteData: INF - writing buffer # 170000 of size 262144\par 10:39:43.408 [11164] <2> int_WriteData: INF - writing buffer # 171000 of size 262144\par 10:39:47.167 [11164] <2> int_WriteData: INF - writing buffer # 172000 of size 262144\par 10:39:50.845 [11164] <2> int_WriteData: INF - writing buffer # 173000 of size 262144\par 10:39:54.531 [11164] <2> int_WriteData: INF - writing buffer # 174000 of size 262144\par 10:39:58.246 [11164] <2> int_WriteData: INF - writing buffer # 175000 of size 262144\par 10:40:02.398 [11164] <2> int_WriteData: INF - writing buffer # 176000 of size 262144\par 10:40:06.398 [11164] <2> int_WriteData: INF - writing buffer # 177000 of size 262144\par 10:40:10.121 [11164] <2> int_WriteData: INF - writing buffer # 178000 of size 262144\par 10:40:13.887 [11164] <2> int_WriteData: INF - writing buffer # 179000 of size 262144\par 10:40:17.940 [11164] <2> int_WriteData: INF - writing buffer # 180000 of size 262144\par 10:40:21.518 [11164] <2> int_WriteData: INF - writing buffer # 181000 of size 262144\par 10:40:25.198 [11164] <2> int_WriteData: INF - writing buffer # 182000 of size 262144\par 10:40:28.734 [11164] <2> int_WriteData: INF - writing buffer # 183000 of size 262144\par 10:40:32.239 [11164] <2> int_WriteData: INF - writing buffer # 184000 of size 262144\par 10:40:36.206 [11164] <2> int_WriteData: INF - writing buffer # 185000 of size 262144\par 10:40:40.036 [11164] <2> int_WriteData: INF - writing buffer # 186000 of size 262144\par 10:40:44.017 [11164] <2> int_WriteData: INF - writing buffer # 187000 of size 262144\par 10:40:47.841 [11164] <2> int_WriteData: INF - writing buffer # 188000 of size 262144\par 10:40:51.598 [11164] <2> int_WriteData: INF - writing buffer # 189000 of size 262144\par 10:40:55.296 [11164] <2> int_WriteData: INF - writing buffer # 190000 of size 262144\par 10:40:59.892 [11164] <2> int_WriteData: INF - writing buffer # 191000 of size 262144\par 10:41:03.968 [11164] <2> int_WriteData: INF - writing buffer # 192000 of size 262144\par 10:41:07.631 [11164] <2> int_WriteData: INF - writing buffer # 193000 of size 262144\par 10:41:11.429 [11164] <2> int_WriteData: INF - writing buffer # 194000 of size 262144\par 10:41:15.267 [11164] <2> int_WriteData: INF - writing buffer # 195000 of size 262144\par 10:41:18.898 [11164] <2> int_WriteData: INF - writing buffer # 196000 of size 262144\par 10:41:22.516 [11164] <2> int_WriteData: INF - writing buffer # 197000 of size 262144\par 10:41:26.466 [11164] <2> int_WriteData: INF - writing buffer # 198000 of size 262144\par 10:41:30.403 [11164] <2> int_WriteData: INF - writing buffer # 199000 of size 262144\par 10:41:34.074 [11164] <2> int_WriteData: INF - writing buffer # 200000 of size 262144\par 10:41:38.139 [11164] <2> int_WriteData: INF - writing buffer # 201000 of size 262144\par 10:41:41.997 [11164] <2> int_WriteData: INF - writing buffer # 202000 of size 262144\par 10:41:45.489 [11164] <2> int_WriteData: INF - writing buffer # 203000 of size 262144\par 10:41:49.410 [11164] <2> int_WriteData: INF - writing buffer # 204000 of size 262144\par 10:41:53.060 [11164] <2> int_WriteData: INF - writing buffer # 205000 of size 262144\par 10:41:56.712 [11164] <2> int_WriteData: INF - writing buffer # 206000 of size 262144\par 10:42:00.569 [11164] <2> int_WriteData: INF - writing buffer # 207000 of size 262144\par 10:42:04.552 [11164] <2> int_WriteData: INF - writing buffer # 208000 of size 262144\par 10:42:08.378 [11164] <2> int_WriteData: INF - writing buffer # 209000 of size 262144\par 10:42:12.393 [11164] <2> int_WriteData: INF - writing buffer # 210000 of size 262144\par 10:42:17.881 [11164] <2> int_WriteData: INF - writing buffer # 211000 of size 262144\par 10:42:22.882 [11164] <2> int_WriteData: INF - writing buffer # 212000 of size 262144\par 10:42:28.111 [11164] <2> int_WriteData: INF - writing buffer # 213000 of size 262144\par 10:42:33.052 [11164] <2> int_WriteData: INF - writing buffer # 214000 of size 262144\par 10:42:38.261 [11164] <2> int_WriteData: INF - writing buffer # 215000 of size 262144\par 10:42:43.847 [11164] <2> int_WriteData: INF - writing buffer # 216000 of size 262144\par 10:42:48.943 [11164] <2> int_WriteData: INF - writing buffer # 217000 of size 262144\par 10:42:54.390 [11164] <2> int_WriteData: INF - writing buffer # 218000 of size 262144\par 10:42:59.838 [11164] <2> int_WriteData: INF - writing buffer # 219000 of size 262144\par 10:43:05.282 [11164] <2> int_WriteData: INF - writing buffer # 220000 of size 262144\par 10:43:10.521 [11164] <2> int_WriteData: INF - writing buffer # 221000 of size 262144\par 10:43:16.182 [11164] <2> int_WriteData: INF - writing buffer # 222000 of size 262144\par 10:43:21.604 [11164] <2> int_WriteData: INF - writing buffer # 223000 of size 262144\par 10:43:26.920 [11164] <2> int_WriteData: INF - writing buffer # 224000 of size 262144\par 10:43:32.497 [11164] <2> int_WriteData: INF - writing buffer # 225000 of size 262144\par 10:43:37.923 [11164] <2> int_WriteData: INF - writing buffer # 226000 of size 262144\par 10:43:43.207 [11164] <2> int_WriteData: INF - writing buffer # 227000 of size 262144\par 10:43:48.064 [11164] <2> int_WriteData: INF - writing buffer # 228000 of size 262144\par 10:43:53.069 [11164] <2> int_WriteData: INF - writing buffer # 229000 of size 262144\par 10:43:57.727 [11164] <2> int_WriteData: INF - writing buffer # 230000 of size 262144\par 10:44:01.898 [11164] <2> int_WriteData: INF - writing buffer # 231000 of size 262144\par 10:44:06.660 [11164] <2> int_WriteData: INF - writing buffer # 232000 of size 262144\par 10:44:11.372 [11164] <2> int_WriteData: INF - writing buffer # 233000 of size 262144\par 10:44:15.895 [11164] <2> int_WriteData: INF - writing buffer # 234000 of size 262144\par 10:44:19.937 [11164] <2> int_WriteData: INF - writing buffer # 235000 of size 262144\par 10:44:24.389 [11164] <2> int_WriteData: INF - writing buffer # 236000 of size 262144\par 10:44:28.686 [11164] <2> int_WriteData: INF - writing buffer # 237000 of size 262144\par 10:44:32.900 [11164] <2> int_WriteData: INF - writing buffer # 238000 of size 262144\par 10:44:36.787 [11164] <2> int_WriteData: INF - writing buffer # 239000 of size 262144\par 10:44:41.096 [11164] <2> int_WriteData: INF - writing buffer # 240000 of size 262144\par 10:44:45.404 [11164] <2> int_WriteData: INF - writing buffer # 241000 of size 262144\par 10:44:49.706 [11164] <2> int_WriteData: INF - writing buffer # 242000 of size 262144\par 10:44:54.202 [11164] <2> int_WriteData: INF - writing buffer # 243000 of size 262144\par 10:44:58.739 [11164] <2> int_WriteData: INF - writing buffer # 244000 of size 262144\par 10:45:02.962 [11164] <2> int_WriteData: INF - writing buffer # 245000 of size 262144\par 10:45:06.923 [11164] <2> int_WriteData: INF - writing buffer # 246000 of size 262144\par 10:45:10.818 [11164] <2> int_WriteData: INF - writing buffer # 247000 of size 262144\par 10:45:14.537 [11164] <2> int_WriteData: INF - writing buffer # 248000 of size 262144\par 10:45:18.700 [11164] <2> int_WriteData: INF - writing buffer # 249000 of size 262144\par 10:45:23.001 [11164] <2> int_WriteData: INF - writing buffer # 250000 of size 262144\par 10:45:27.101 [11164] <2> int_WriteData: INF - writing buffer # 251000 of size 262144\par 10:45:31.259 [11164] <2> int_WriteData: INF - writing buffer # 252000 of size 262144\par 10:45:36.089 [11164] <2> int_WriteData: INF - writing buffer # 253000 of size 262144\par 10:45:40.709 [11164] <2> int_WriteData: INF - writing buffer # 254000 of size 262144\par 10:45:45.053 [11164] <2> int_WriteData: INF - writing buffer # 255000 of size 262144\par 10:45:49.158 [11164] <2> int_WriteData: INF - writing buffer # 256000 of size 262144\par 10:45:53.333 [11164] <2> int_WriteData: INF - writing buffer # 257000 of size 262144\par 10:45:57.528 [11164] <2> int_WriteData: INF - writing buffer # 258000 of size 262144\par 10:46:00.372 [11164] <2> int_CloseImage: INF - Backup - closing \par 10:46:00.373 [11164] <4> CleanUpShM: INF - dbclient waited 13420 times for empty buffer, delayed 13540 times\par 10:46:11.467 [11164] <2> int_logDateRange: INF - Start Time = 02/27/12 19:15:51\par 10:46:11.467 [11164] <2> int_logDateRange: INF - End Time = 02/29/12 19:15:51\par 10:46:11.470 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:46:11.470 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+0,1,50,2,2,0+bmmi-db-prsrv2.txt\par 10:46:11.470 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:46:11.470 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+0,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:46:11.471 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:46:11.471 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:46:11.474 [11164] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:46:11.474 [11164] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45569 TO 25.1.1.131.1556 fd = 17\par 10:46:13.909 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:46:13.909 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:46:13.909 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:46:13.909 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:46:13.909 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:46:13.909 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:46:13.909 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:46:13.909 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 1780\par 10:46:13.911 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:46:13.911 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+1780,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:46:13.912 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:46:13.912 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:46:13.912 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:46:13.912 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:46:13.912 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:46:13.912 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:46:13.912 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:46:13.912 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 1674\par 10:46:13.912 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:46:13.912 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+1674,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:46:13.913 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:46:13.913 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:46:13.913 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:46:13.913 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:46:13.913 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:46:13.913 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:46:13.913 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:46:13.913 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3264\par 10:46:13.913 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:46:13.913 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3264,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:46:14.283 [11164] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:46:14.295 [11164] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:46:14.295 [11164] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45586 TO 25.1.1.131.1556 fd = 18\par 10:46:24.957 [11171] <2> int_StartJob: INF - copyID: 1 - 1330414691\par \par 10:46:25.026 [11171] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:46:29.324 [11171] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 10:46:33.774 [11171] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 10:46:41.523 [11171] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 10:46:47.822 [11171] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 10:46:53.863 [11171] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 10:46:59.443 [11171] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 10:47:04.880 [11171] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 10:47:09.831 [11171] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 10:47:14.653 [11171] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 10:47:20.919 [11171] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 10:47:26.618 [11171] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 10:47:31.360 [11171] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 10:47:36.763 [11171] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 10:47:41.494 [11171] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 10:47:46.381 [11171] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 10:47:51.135 [11171] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 10:47:55.832 [11171] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 10:48:01.336 [11171] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 10:48:06.598 [11171] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 10:48:10.685 [11171] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 10:48:15.149 [11171] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 10:48:19.539 [11171] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 10:48:23.972 [11171] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 10:48:28.720 [11171] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 10:48:34.103 [11171] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 10:48:38.907 [11171] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 10:48:43.643 [11171] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 10:48:48.050 [11171] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 10:48:52.676 [11171] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 10:48:56.798 [11171] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 10:49:01.362 [11171] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 10:49:05.527 [11171] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 10:49:10.101 [11171] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 10:49:15.181 [11171] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 10:49:20.484 [11171] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 10:49:26.615 [11171] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 10:49:31.954 [11171] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 10:49:37.304 [11171] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 10:49:42.775 [11171] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 10:49:48.505 [11171] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 10:49:54.313 [11171] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 10:50:00.160 [11171] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 10:50:05.905 [11171] <2> int_WriteData: INF - writing buffer # 43000 of size 262144\par 10:50:11.718 [11171] <2> int_WriteData: INF - writing buffer # 44000 of size 262144\par 10:50:22.197 [11171] <2> int_CloseImage: INF - Backup - closing \par 10:50:22.197 [11171] <4> CleanUpShM: INF - dbclient waited 1195 times for empty buffer, delayed 1195 times\par 10:50:32.242 [11171] <2> int_logDateRange: INF - Start Time = 02/27/12 19:28:58\par 10:50:32.242 [11171] <2> int_logDateRange: INF - End Time = 02/29/12 19:28:58\par 10:50:32.244 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:50:32.244 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:50:32.251 [11171] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:50:32.252 [11171] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45659 TO 25.1.1.131.1556 fd = 17\par 10:50:35.003 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:50:35.004 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:50:35.004 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:50:35.004 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:50:35.004 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:50:35.004 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:50:35.004 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:50:35.004 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 3938\par 10:50:35.004 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:50:35.004 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+3938,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:50:35.005 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:50:35.005 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:50:35.005 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:50:35.005 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:50:35.005 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:50:35.005 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:50:35.005 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:50:35.005 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 4694\par 10:50:35.005 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:50:35.005 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+4694,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:50:35.006 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:50:35.006 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:50:35.006 [11164] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:50:35.006 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:50:35.006 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:50:35.006 [11164] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:50:35.006 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:50:35.006 [11164] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 2276\par 10:50:35.006 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:50:35.006 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+2276,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:50:40.867 [11171] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:50:40.872 [11171] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:50:40.872 [11171] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45689 TO 25.1.1.131.1556 fd = 18\par 10:50:46.070 [11164] <2> int_StartJob: INF - copyID: 1 - 1330414952\par \par 10:50:46.173 [11164] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:50:50.145 [11164] <2> int_WriteData: INF - writing buffer # 1000 of size 262144\par 10:50:53.674 [11164] <2> int_WriteData: INF - writing buffer # 2000 of size 262144\par 10:50:57.575 [11164] <2> int_WriteData: INF - writing buffer # 3000 of size 262144\par 10:51:01.477 [11164] <2> int_WriteData: INF - writing buffer # 4000 of size 262144\par 10:51:05.399 [11164] <2> int_WriteData: INF - writing buffer # 5000 of size 262144\par 10:51:09.342 [11164] <2> int_WriteData: INF - writing buffer # 6000 of size 262144\par 10:51:13.187 [11164] <2> int_WriteData: INF - writing buffer # 7000 of size 262144\par 10:51:17.436 [11164] <2> int_WriteData: INF - writing buffer # 8000 of size 262144\par 10:51:21.858 [11164] <2> int_WriteData: INF - writing buffer # 9000 of size 262144\par 10:51:25.724 [11164] <2> int_WriteData: INF - writing buffer # 10000 of size 262144\par 10:51:29.737 [11164] <2> int_WriteData: INF - writing buffer # 11000 of size 262144\par 10:51:33.663 [11164] <2> int_WriteData: INF - writing buffer # 12000 of size 262144\par 10:51:37.684 [11164] <2> int_WriteData: INF - writing buffer # 13000 of size 262144\par 10:51:41.835 [11164] <2> int_WriteData: INF - writing buffer # 14000 of size 262144\par 10:51:45.832 [11164] <2> int_WriteData: INF - writing buffer # 15000 of size 262144\par 10:51:49.716 [11164] <2> int_WriteData: INF - writing buffer # 16000 of size 262144\par 10:51:54.325 [11164] <2> int_WriteData: INF - writing buffer # 17000 of size 262144\par 10:51:58.344 [11164] <2> int_WriteData: INF - writing buffer # 18000 of size 262144\par 10:52:02.430 [11164] <2> int_WriteData: INF - writing buffer # 19000 of size 262144\par 10:52:06.478 [11164] <2> int_WriteData: INF - writing buffer # 20000 of size 262144\par 10:52:10.419 [11164] <2> int_WriteData: INF - writing buffer # 21000 of size 262144\par 10:52:14.499 [11164] <2> int_WriteData: INF - writing buffer # 22000 of size 262144\par 10:52:18.203 [11164] <2> int_WriteData: INF - writing buffer # 23000 of size 262144\par 10:52:22.146 [11164] <2> int_WriteData: INF - writing buffer # 24000 of size 262144\par 10:52:26.304 [11164] <2> int_WriteData: INF - writing buffer # 25000 of size 262144\par 10:52:30.300 [11164] <2> int_WriteData: INF - writing buffer # 26000 of size 262144\par 10:52:35.834 [11164] <2> int_WriteData: INF - writing buffer # 27000 of size 262144\par 10:52:39.974 [11164] <2> int_WriteData: INF - writing buffer # 28000 of size 262144\par 10:52:44.692 [11164] <2> int_WriteData: INF - writing buffer # 29000 of size 262144\par 10:52:49.341 [11164] <2> int_WriteData: INF - writing buffer # 30000 of size 262144\par 10:52:53.680 [11164] <2> int_WriteData: INF - writing buffer # 31000 of size 262144\par 10:52:57.965 [11164] <2> int_WriteData: INF - writing buffer # 32000 of size 262144\par 10:53:02.446 [11164] <2> int_WriteData: INF - writing buffer # 33000 of size 262144\par 10:53:06.505 [11164] <2> int_WriteData: INF - writing buffer # 34000 of size 262144\par 10:53:10.277 [11164] <2> int_WriteData: INF - writing buffer # 35000 of size 262144\par 10:53:14.294 [11164] <2> int_WriteData: INF - writing buffer # 36000 of size 262144\par 10:53:18.377 [11164] <2> int_WriteData: INF - writing buffer # 37000 of size 262144\par 10:53:22.103 [11164] <2> int_WriteData: INF - writing buffer # 38000 of size 262144\par 10:53:26.030 [11164] <2> int_WriteData: INF - writing buffer # 39000 of size 262144\par 10:53:29.979 [11164] <2> int_WriteData: INF - writing buffer # 40000 of size 262144\par 10:53:34.168 [11164] <2> int_WriteData: INF - writing buffer # 41000 of size 262144\par 10:53:38.259 [11164] <2> int_WriteData: INF - writing buffer # 42000 of size 262144\par 10:53:49.271 [11164] <2> int_CloseImage: INF - Backup - closing \par 10:53:49.272 [11164] <4> CleanUpShM: INF - dbclient waited 2313 times for empty buffer, delayed 2363 times\par 10:53:59.345 [11164] <2> int_logDateRange: INF - Start Time = 02/27/12 19:46:14\par 10:53:59.345 [11164] <2> int_logDateRange: INF - End Time = 02/29/12 19:46:14\par 10:53:59.348 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:53:59.348 [11164] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:53:59.351 [11164] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:53:59.351 [11164] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45740 TO 25.1.1.131.1556 fd = 17\par 10:54:01.211 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1527: 0: in failed file cache: 9 0x00000009\par 10:54:01.211 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1528: 0: in failed file cache name: NULL\par 10:54:01.211 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1529: 0: in failed file cache service: testdaemon\par 10:54:01.211 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:54:01.211 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:54:01.212 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:54:01.212 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:54:01.212 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 1692\par 10:54:01.213 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:54:01.213 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+1692,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:54:01.214 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:54:01.214 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:54:01.214 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:54:01.214 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:54:01.214 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:54:01.214 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:54:01.214 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:54:01.214 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 1170\par 10:54:01.214 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:54:01.214 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+1170,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:54:02.235 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1476: 0: in failed cache: 9 0x00000009\par 10:54:02.235 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1477: 0: in failed cache name: NULL\par 10:54:02.235 [11171] <2> vnet_cached_getaddrinfo_and_update: ../../libvlibs/vnet_addrinfo.c.1478: 0: in failed cache service: testdaemon\par 10:54:02.235 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2474: 0: vnet_cached_getaddrinfo failed: 6 0x00000006\par 10:54:02.235 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2475: 0: vnet_cached_getaddrinfo failed ret: 9 0x00000009\par 10:54:02.235 [11171] <2> vnet_cached_get_service_port: ../../libvlibs/vnet_addrinfo.c.2476: 0: vnet_cached_getaddrinfo failed service: testdaemon\par 10:54:02.235 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1827: 0: vnet_cached_get_service_port() failed: 6 0x00000006\par 10:54:02.235 [11171] <2> is_pbxable_server: ../../libvlibs/vnet_connect.c.1828: 0: service: 2192\par 10:54:02.235 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:54:02.235 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1e8/a445d5e8+2192,1,4,2,2,0+bmmi-db-prsrv2.txt\par 10:54:13.313 [11171] <2> int_StartJob: INF - copyID: 1 - 1330415159\par \par 10:54:13.321 [11171] <2> int_WriteData: INF - writing buffer # 1 of size 262144\par 10:54:13.483 [11171] <2> int_CloseImage: INF - Backup - closing \par 10:54:13.483 [11171] <4> CleanUpShM: INF - dbclient waited 2 times for empty buffer, delayed 2 times\par 10:54:23.565 [11171] <2> int_logDateRange: INF - Start Time = 02/27/12 19:50:39\par 10:54:23.565 [11171] <2> int_logDateRange: INF - End Time = 02/29/12 19:50:39\par 10:54:23.566 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:54:23.566 [11171] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:54:23.576 [11171] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:54:23.576 [11171] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45778 TO 25.1.1.131.1556 fd = 17\par 10:54:32.758 [11164] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:54:32.758 [11164] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:54:32.766 [11164] <4> sbtend: INF - --- END of SESSION ---\par 10:54:32.890 [11171] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:54:32.890 [11171] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:54:32.890 [11171] <2> int_PerformMetadataCataloging: INF - freeing node for backup piece \par 10:54:32.891 [11171] <4> sbtend: INF - --- END of SESSION ---\par 10:54:33.042 [11164] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:54:33.042 [11164] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:54:33.042 [11164] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:54:33.042 [11164] <2> int_GetMMInfo: INF - Initialized Signal\par 10:54:33.042 [11164] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:54:33.194 [11171] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:54:33.194 [11171] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:54:33.194 [11171] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:54:33.194 [11171] <2> int_GetMMInfo: INF - Initialized Signal\par 10:54:33.194 [11171] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:54:36.262 [11164] <4> sbtend: INF - --- END of SESSION ---\par 10:54:36.271 [11171] <4> sbtend: INF - --- END of SESSION ---\par 10:59:40.976 [13140] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:59:40.976 [13140] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:59:40.976 [13140] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:59:40.976 [13140] <2> int_GetMMInfo: INF - Initialized Signal\par 10:59:40.976 [13140] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:59:41.519 [13141] <8> xbsa_GetEnv: WRN - NBBSA_SCHEDULE not found in environment block\par \par 10:59:41.519 [13141] <2> int_GetOracleVersion: INF - ORACLE_HOME= \par 10:59:41.519 [13141] <2> int_LogSystemInfo: INF - \par Veritas NetBackup for Oracle - Release 7.1 (2011020313)\par \tab System name:\tab SunOS\par \tab Node name:\tab bmmi-db-prsrv2\par \tab Release:\tab 5.10\par \tab Version:\tab Generic_118833-36\par \tab Machine:\tab sun4u\par \tab User name: \tab oraret\par \tab Client Host: \tab bmmi-db-prsrv2\par \par 10:59:41.519 [13141] <2> int_GetMMInfo: INF - Initialized Signal\par 10:59:41.519 [13141] <2> int_GetMMInfo: INF - support for Proxy Copy enabled\par 10:59:42.514 [13141] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:59:42.514 [13141] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:59:42.515 [13140] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6635: 0: fopen() failed: 2 0x00000002\par 10:59:42.515 [13140] <2> file_to_addrinfo: ../../libvlibs/vnet_addrinfo.c.6636: 0: fopen() failed: /usr/openv/var/host_cache/1ef/b4838bef+bprd,1,4,2,2,0+bmmi-nbusrv.txt\par 10:59:42.518 [13141] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:59:42.518 [13141] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45878 TO 25.1.1.131.1556 fd = 17\par 10:59:42.519 [13140] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:59:42.519 [13140] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45879 TO 25.1.1.131.1556 fd = 17\par 10:59:42.563 [13140] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:59:42.575 [13140] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:59:42.575 [13140] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45880 TO 25.1.1.131.1556 fd = 18\par 10:59:42.596 [13141] <2> xbsa_ProgressLogSetup: INF - No progress log: Job will proceed without progress logging\par 10:59:42.604 [13141] <2> vnet_pbxConnect: pbxConnectEx Succeeded\par 10:59:42.604 [13141] <2> logconnections: BPRD CONNECT FROM 25.1.1.129.45881 TO 25.1.1.131.1556 fd = 18\par \par }