09:54:28.418 [9225] <2> logparams: bpfis create -nbu -owner NBU -id finux112_1355324121 -bpstart_to 300 -bpend_to 300 -backup_copy 0 -ru root -pt 20 -clnt finux112 -rg other -fim VxFS_Snapshot:cache=/dev/rdisk/disk14 -class z-test-FINUX112-Test -sched OneTime -fso -S finms-nbmaster -jobid 93768 09:54:28.418 [9225] <2> bpfis main: received FIM as [37] VxFS_Snapshot:cache=/dev/rdisk/disk14 09:54:28.419 [9225] <4> bpfis: Starting keep alive process. 09:54:28.420 [9225] <4> bpfis: Keep alive process id<9226>. 09:54:28.420 [9225] <4> bpfis: Stoping keep alive process. pid<9226>. 09:54:28.421 [9225] <4> bpfis: INF - BACKUP START 9225 09:54:28.421 [9225] <2> bpfis main: receive filelist: 09:54:28.421 [9225] <2> bpfis main: receive filelist: 09:54:28.421 [9225] <2> bpfis main: receive filelist: 09:54:29.256 [9225] <8> file_to_cache_item: [vnet_addrinfo.c:6555] fopen() failed ERRNO=2 FILE=/usr/openv/var/host_cache/1a6/60a3bfa6+bprd,1,40,2,1,0+finms-nbmaster.txt 09:54:29.279 [9225] <2> vnet_pbxConnect: pbxConnectEx Succeeded 09:54:29.281 [9225] <2> logconnections: BPRD CONNECT FROM 10.36.16.112.55959 TO 10.36.25.57.1556 fd = 6 09:54:29.281 [9225] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 09:54:29.412 [9225] <2> vnet_pbxConnect: pbxConnectEx Succeeded 09:54:29.413 [9225] <2> logconnections: BPRD CONNECT FROM 10.36.16.112.55960 TO 10.36.25.57.1556 fd = 6 09:54:29.413 [9225] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 09:54:29.891 [9225] <4> bpfis: INF - FIS_ID=finux112_1355324121 09:54:29.901 [9225] <4> bpfis: INF - Freezing /dev/vgimage_test/rlvol1 using snapshot method VxFS_Snapshot. 09:54:29.901 [9225] <4> bpfis: INF - ACT=finux112 09:54:29.911 [9225] <2> do_cmd: execing cmd: /sbin/mount 09:54:29.911 [9225] <2> do_cmd: argv[0]=/sbin/mount 09:54:29.911 [9225] <2> do_cmd: argv[1]=-F 09:54:29.911 [9225] <2> do_cmd: argv[2]=vxfs 09:54:29.911 [9225] <2> do_cmd: argv[3]=-r 09:54:29.911 [9225] <2> do_cmd: argv[4]=-o 09:54:29.911 [9225] <2> do_cmd: argv[5]=snapof=/test 09:54:29.911 [9225] <2> do_cmd: argv[6]=/dev/rdisk/isk14 09:54:29.911 [9225] <2> do_cmd: argv[7]=/tmp/VXSNAAAA009225 09:54:29.915 [9225] <32> bpfis: FTL - VfMS error 11; see following messages: 09:54:29.915 [9225] <32> bpfis: FTL - Fatal method error was reported 09:54:29.916 [9225] <32> bpfis: FTL - vfm_freeze: method: VxFS_Snapshot, type: FIM, function: VxFS_Snapshot_freeze 09:54:29.916 [9225] <32> bpfis: FTL - VfMS method error 3; see following message: 09:54:29.916 [9225] <32> bpfis: FTL - VxFS_Snapshot_mount: V_mount() failed with status=77, exit_status=1(Not owner) 09:54:29.916 [9225] <32> bpfis: FTL - VfMS error 11; see following messages: 09:54:29.916 [9225] <32> bpfis: FTL - Fatal method error was reported 09:54:29.916 [9225] <32> bpfis: FTL - vfm_freeze: method: VxFS_Snapshot, type: FIM, function: VxFS_Snapshot_freeze 09:54:29.916 [9225] <32> bpfis: FTL - VfMS method error 3; see following message: 09:54:29.916 [9225] <32> bpfis: FTL - VxFS_Snapshot_mount: V_mount() failed with status=77, exit_status=1(Not owner) 09:54:29.916 [9225] <16> bpfis: FTL - snapshot creation failed, status 156 09:54:29.916 [9225] <4> bpfis: INF - Thawing /dev/vgimage_test/rlvol1 using snapshot method VxFS_Snapshot. 09:54:29.916 [9225] <8> bpfis: WRN - /dev/vgimage_test/rlvol1 is not frozen 09:54:29.916 [9225] <8> bpfis: WRN - snapshot delete returned status 20 09:54:29.917 [9225] <4> bpfis: Starting keep alive process. 09:54:29.918 [9225] <4> bpfis: Keep alive process id<9231>. 09:54:29.918 [9225] <4> bpfis: Stoping keep alive process. pid<9231>. 09:54:29.918 [9225] <4> bpfis: INF - EXIT STATUS 156: snapshot error encountered 09:54:34.902 [9259] <2> logparams: bpfis delete -nbu -id finux112_1355324121 -bpstart_to 300 -bpend_to 300 -clnt finux112 -S finms-nbmaster -jobid 93768 -copy 1 -fim VxFS_Snapshot:cache=/dev/rdisk/disk14 09:54:34.903 [9259] <2> bpfis main: received FIM as [37] VxFS_Snapshot:cache=/dev/rdisk/disk14 09:54:34.903 [9259] <4> bpfis: Starting keep alive process. 09:54:34.905 [9259] <4> bpfis: Keep alive process id<9260>. 09:54:34.905 [9259] <4> bpfis: Acquiring snapshot lock:retry count [0] 09:54:34.905 [9259] <2> getFileName: FileName is [/usr/openv/netbackup/online_util/fi_cntl/finux112_1355324121_copy1.lock] 09:54:34.905 [9259] <2> rw_lock: lock Acquired 09:54:34.905 [9259] <4> bpfis: Stoping keep alive process. pid<9260>. 09:54:34.911 [9259] <2> vnet_pbxConnect: pbxConnectEx Succeeded 09:54:34.912 [9259] <2> logconnections: BPRD CONNECT FROM 10.36.16.112.55980 TO 10.36.25.57.1556 fd = 6 09:54:34.912 [9259] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 09:54:36.113 [9259] <2> vnet_pbxConnect: pbxConnectEx Succeeded 09:54:36.114 [9259] <2> logconnections: BPRD CONNECT FROM 10.36.16.112.55982 TO 10.36.25.57.1556 fd = 7 09:54:36.114 [9259] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2 09:54:36.204 [9259] <4> bpfis: INF - BACKUP START 9259 09:54:36.205 [9259] <32> bpfis: FTL - cannot open /usr/openv/netbackup/online_util/fi_cntl/bpfis.fim.finux112_1355324121.1.0 09:54:36.205 [9259] <4> bpfis main: Overriding original online_util() status <12> with <1542>. 09:54:36.205 [9259] <4> bpfis: Starting keep alive process. 09:54:36.207 [9259] <4> bpfis: Keep alive process id<9263>. 09:54:36.207 [9259] <2> deleteReference: reference not found in the list 09:54:36.207 [9259] <4> bpfis: Delete reference: status [-4] 09:54:36.216 [9259] <2> writeSnapshotLockFile: Writing type[2] refcount[0] 09:54:36.216 [9259] <2> getFileName: FileName is [/usr/openv/netbackup/online_util/fi_cntl/finux112_1355324121_copy1.lock] 09:54:36.216 [9259] <2> unlockSnapshot: file[/usr/openv/netbackup/online_util/fi_cntl/finux112_1355324121_copy1.lock] : zero reference count 09:54:36.216 [9259] <4> bpfis: Released snapshot lock: status [0] 09:54:36.216 [9259] <4> bpfis: Stoping keep alive process. pid<9263>. 09:54:36.216 [9259] <4> bpfis Exit: Deleting snapshot lock files from client for id [finux112_1355324121] and copy_number [1] 09:54:36.216 [9259] <2> getFileName: FileName is [/usr/openv/netbackup/online_util/fi_cntl/finux112_1355324121_copy1.lock] 09:54:36.216 [9259] <2> deleteSnapshotLockFile: file[/usr/openv/netbackup/online_util/fi_cntl/finux112_1355324121_copy1.lock] deleted: status[0] 09:54:36.216 [9259] <4> bpfis: INF - EXIT STATUS 1542: An existing snapshot is no longer valid and cannot be mounted for subsequent operations