00:37:32.789 [1948.4772] <2> bpdbm: lock file fd = 448
00:37:32.789 [1948.4772] <4> bpdbm: Locale info: message=zh, ctype=zh, time=zh, collate=zh, num=zh
00:37:32.789 [1948.4772] <2> getIDIRSTRUCT: ?
00:37:32.789 [1948.4772] <2> getIDIRSTRUCT: ?
00:37:32.789 [1948.4772] <4> db_error_add_to_file: INITIATING bpdbm: NetBackup 7.5 2012091608 on vm08r2 IDIRSTRUCT=2 (VERBOSE = 5)
00:37:32.789 [1948.4772] <4> bpdbm: INITIATING bpdbm: NetBackup 7.5 2012091608 on vm08r2 IDIRSTRUCT=2 (VERBOSE = 5)
00:37:32.789 [1948.4772] <2> bpdbm: wakeup 60 minutes, not logging queries, catching sigs
00:37:32.789 [1948.4772] <2> clean_locks: ?
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\Internal_PG.lock
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\class_directory.lock
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\po1-vss-snap-only.lock
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\po2-vss-snap-backup.lock
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\po3-adv-slp.lock
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\po4-adv-same-slp.lock
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\po5-adv-same-too-slp.lock
00:37:32.789 [1948.4772] <4> clean_locks: Cleaning up class lock file C:\Program Files\Veritas\NetBackup\db\class_locks\po6-vss-sql-slp.lock
00:37:32.789 [1948.4772] <2> bpdbm: Checking for catalog conversion file: C:\Program Files\Veritas\NetBackup\db\config\cat_convert_now
00:37:32.805 [1948.4772] <2> insert_if_not_dup: [vnet_addrinfo.c:5705] ignoring IPv6 link local 0 0x0
00:37:32.805 [1948.4772] <2> daemon_startup_listeners: 4 listening for legacy service bpdbm
00:37:32.805 [1948.4772] <2> daemon_startup_listeners: listening for vnetd service bpdbm
00:37:32.805 [1948.4772] <2> vnet_registerPBXServer: ../../libvlibs/vnet_pbx.c.132: pbxRegisterEx successful at 10.200.108.193:5126/bpdbm, returns with 0 alt_addrs
00:37:32.805 [1948.4772] <2> start_bpjobd: "C:\Program Files\Veritas\NetBackup\bin\bpjobd.exe", pid=3180
00:37:32.805 [1948.4772] <2> listen_loop: ready for bpdbm connections
00:37:33.805 [1948.4772] <2> vnet_cache_nbconf: vnet_private.c.181: 0: caching vnet data: 0 0x00000000
00:38:18.023 [1948.4772] <2> listen_loop: socket fd from accept() is 532
00:38:18.023 [1948.4772] <2> listen_loop: Locale info: message=zh, ctype=zh, time=zh, collate=zh, num=zh
00:38:18.023 [1948.4772] <2> init_resilient_cache: [vnet_nbrntd.c:869] Initialize resilient cache. 0 0x0
00:38:18.117 [2980.3196] <2> getIDIRSTRUCT: ?
00:38:18.133 [2980.3196] <2> logconnections: BPDBM ACCEPT FROM 10.200.108.193.58806 TO 10.200.108.193.13721 fd = 532
00:38:18.133 [2980.3196] <2> init_resilient_cache: [vnet_nbrntd.c:869] Initialize resilient cache. 0 0x0
00:38:18.133 [2980.3196] <2> vnet_pcache_init_table: [vnet_private.c:235] starting cache size 200 0xc8
00:38:18.133 [2980.3196] <2> vnet_cached_getnameinfo: [vnet_addrinfo.c:1895] found via getnameinfo OUR_HOST=vm08r2 IPSTR=10.200.108.193
00:38:18.133 [2980.3196] <2> bpdbm: VERBOSE = 5
00:38:18.133 [2980.3196] <2> db_getrequest_vxss: Entering
00:38:18.133 [2980.3196] <8> vnet_check_vxss_server_magic: [vnet_vxss_helper.c:495] VxSS magic 1041669 0xfe505
00:38:18.133 [2980.3196] <8> vnet_check_vxss_server_magic: [vnet_vxss_helper.c:496] remote_vxss 296 0x128
00:38:18.133 [2980.3196] <8> vnet_check_vxss_server_magic: [vnet_vxss_helper.c:538] Ignoring VxSS authentication 2 0x2
00:38:18.133 [2980.3196] <2> mlic_get_nb_features: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.461: license.txt reread = <Thu Jan 01 08:00:00 1970
>
00:38:18.133 [2980.3196] <2> LOCAL CLASS_ATT_DEFS: Product ID = 6
00:38:18.133 [2980.3196] <2> mlic_check_product_id_line: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.526: matched product ID = 6 0x00000006
00:38:18.133 [2980.3196] <2> mlic_check_product_id_line: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.529: mis-matched old product ID = 6 0x00000006
00:38:18.133 [2980.3196] <2> mlic_check_product_id_line: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.530: mis-matched new product ID = 7 0x00000007
00:38:18.133 [2980.3196] <2> adjust_Vnydef: Change for policy type 26, was 2, now 1
00:38:18.133 [2980.3196] <2> ss_db: Q_SS_ONEPOLICY_IMPACT
00:38:18.133 [2980.3196] <4> TZ: Recv Timezone offset=-28800-local=-28800
00:38:18.133 [2980.3196] <2> db_logclassrec: qtype=0 policy=po9-sql, name=?, options=0x0
00:38:18.133 [2980.3196] <2> db_logclassrec: names is NULL
00:38:18.133 [2980.3196] <2> db_logclassinfo: client type: 15, follow nfs mounts: 0
00:38:18.133 [2980.3196] <2> db_logclassinfo: cross mount points: 0
00:38:18.133 [2980.3196] <2> db_logclassinfo: client compress: 0, client encrypt: 0
00:38:18.133 [2980.3196] <2> db_logclassinfo: priority: 0, disaster recovery: 0, maxjobs/policy: 2147483647
00:38:18.133 [2980.3196] <2> db_logclassinfo: collect bmr info: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: max frag size: 0, active: yes
00:38:18.133 [2980.3196] <2> db_logclassinfo: classID: F2DB9A69C1924052976A762BBFC0472A
00:38:18.133 [2980.3196] <2> db_logclassinfo: collect tir: 0,  proxy client: ?
00:38:18.133 [2980.3196] <2> db_logclassinfo: enable PFI: 1
00:38:18.133 [2980.3196] <2> db_logclassinfo: extended security information: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: individual file restore from raw: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: block incremental: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: multistreaming: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: effective date: 0
00:38:18.133 [2980.3196] <2> db_logclassinfo: number of copies: 1
00:38:18.133 [2980.3196] <2> db_logclassinfo: fail on error (0): 0 0 0 0 0 0 0 0 0 0
00:38:18.133 [2980.3196] <2> db_logclassinfo: checkpoint enabled: no interval: 0 minutes
00:38:18.133 [2980.3196] <2> db_logclassinfo: perform snapshots: yes
00:38:18.133 [2980.3196] <2> db_logclassinfo: backup copy: Standard (0)
00:38:18.133 [2980.3196] <2> db_logclassinfo: job_subtype backup: 0
00:38:18.133 [2980.3196] <2> db_logclassinfo: offhost backup: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: enable instant recovery: yes
00:38:18.133 [2980.3196] <2> db_logclassinfo: use alternate client: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: alternate client name: ?
00:38:18.133 [2980.3196] <2> db_logclassinfo: use virtual machine: None (0)
00:38:18.133 [2980.3196] <2> db_logclassinfo: use data mover: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: data mover type: Media-Server-Copy (2)
00:38:18.133 [2980.3196] <2> db_logclassinfo: snapshot method: VSS
00:38:18.133 [2980.3196] <2> db_logclassinfo: snapshot arguments: prov_type=0,snap_attr=0,max_snapshots=1
00:38:18.133 [2980.3196] <2> db_logclassinfo: keyword: ?
00:38:18.133 [2980.3196] <2> db_logclassinfo: residence: slp2 - - - - - - - - -
00:38:18.133 [2980.3196] <2> db_logclassinfo: pool: NetBackup - - - - - - - - -
00:38:18.133 [2980.3196] <2> db_logclassinfo: data class: -
00:38:18.133 [2980.3196] <2> db_logclassinfo: backup command: ?
00:38:18.133 [2980.3196] <2> db_logclassinfo: restore command: ?
00:38:18.133 [2980.3196] <2> db_logclassinfo: share group: *ANY*
00:38:18.133 [2980.3196] <2> db_logclassinfo: residence is storage service: yes
00:38:18.133 [2980.3196] <2> db_logclassinfo: granular restore info: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: generation: 0
00:38:18.133 [2980.3196] <2> db_logclassinfo: ignore client direct: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: use fast backup: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: Hyper-V server: ? (0000000000000000)
00:38:18.133 [2980.3196] <2> db_logclassinfo: exchange_source: 3
00:38:18.133 [2980.3196] <2> db_logclassinfo: enable metadata indexing: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: use application discovery: no
00:38:18.133 [2980.3196] <2> db_logclassinfo: application discovery time: 28800
00:38:18.133 [2980.3196] <2> db_logclassinfo: index server name: ?
00:38:18.133 [2980.3196] <2> db_logclassrec: clients is NULL
00:38:18.133 [2980.3196] <2> db_logclassrec: include is NULL
00:38:18.133 [2980.3196] <2> db_logclassrec: exclude is NULL
00:38:18.133 [2980.3196] <2> db_logschedrec: ->label=Default-Application-Backup type=2 frequency=604800
00:38:18.133 [2980.3196] <2> db_logschedrec: incr type=0
00:38:18.133 [2980.3196] <2> db_logschedrec: stage priority=-1
00:38:18.133 [2980.3196] <2> db_logschedrec: alt read host=?
00:38:18.133 [2980.3196] <2> db_logschedrec: day[0]: open=0000000000, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: day[1]: open=0000000000, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: day[2]: open=0000000000, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: day[3]: open=0000000000, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: day[4]: open=0000000000, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: day[5]: open=0000000000, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: day[6]: open=0000000000, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: residence: - - - - - - - - - -
00:38:18.133 [2980.3196] <2> db_logschedrec: pool: - - - - - - - - - -
00:38:18.133 [2980.3196] <2> db_logschedrec: max frag size: 0
00:38:18.133 [2980.3196] <2> db_logschedrec: max mpx: 1
00:38:18.133 [2980.3196] <2> db_logschedrec: number of copies: 0
00:38:18.133 [2980.3196] <2> db_logschedrec: fail on error (0): 0 0 0 0 0 0 0 0 0 0
00:38:18.133 [2980.3196] <2> db_logschedrec: calendar: 0
00:38:18.133 [2980.3196] <2> db_logschedrec: Null schedule object
00:38:18.133 [2980.3196] <2> db_logschedrec: s_checksum_validation: 0
00:38:18.133 [2980.3196] <2> db_logschedrec: s_fast_recovery: 0
00:38:18.133 [2980.3196] <2> db_logschedrec: unused_window: open=0, duration=0
00:38:18.133 [2980.3196] <2> db_logschedrec: sched_indexing=0
00:38:18.133 [2980.3196] <2> db_logclassrec: Normal Policy
00:38:18.133 [2980.3196] <2> db_logclassrec: protocol version: 750000
00:38:18.133 [2980.3196] <2> db_logclassrec: TZ offset: 144000
00:38:18.133 [2980.3196] <2> db_logclassrec: audit_reason: ?
00:38:18.133 [2980.3196] <2> ValidateOnePolicy: SLP validation of policy po9-sql
00:38:18.133 [2980.3196] <2> DbmSLP::get_DBM_SLP: Entering
00:38:18.133 [2980.3196] <2> DbmOdbcConnect::DbmOdbcConnect: ENTERING
00:38:18.133 [2980.3196] <2> ReadVxDBMS_ConfFile: Acquiring mutex
00:38:18.133 [2980.3196] <2> ReadVxDBMS_ConfFile: Acquiring read lock on C:\Program Files\Veritas\NetBackupDB\data\vxdbms_conf.lock
00:38:18.133 [2980.3196] <2> ReadVxDBMS_ConfFile: Acquired read lock on C:\Program Files\Veritas\NetBackupDB\data\vxdbms_conf.lock successfully with fd (464)
00:38:18.133 [2980.3196] <2> ReadVxDBMS_ConfFile: unlocking on fd (464) for C:\Program Files\Veritas\NetBackupDB\data\vxdbms_conf.lock
00:38:18.133 [2980.3196] <2> ReadVxDBMS_ConfFile: Releasing mutex
00:38:18.180 [2980.3196] <2> DbmOdbcConnect::initialize_odbc: Connecting to a database. connect_string=<DRIVER=NB SQL Anywhere;PROWS=1000;PBUF=8m;CS=utf8;UID=DBM_MAIN;PWD=******;LINKS=shmem,tcpip{PORT=13785};ENG=NB_vm08r2;DBN=NBDB;CON=DBM_2980_1>
00:38:18.180 [2980.3196] <2> DbmOdbcConnect::setIsolationLevel: (-1) Isolation Level=<32> (SNAPSHOT)
00:38:18.180 [2980.3196] <2> DbmOdbcView::DbmOdbcView: (.1) Entering
00:38:18.180 [2980.3196] <2> DbmOdbcView::executeSql: (-1.1) Executing "SELECT @@SPID"
00:38:18.180 [2980.3196] <2> DbmOdbcView::executeSql: SQL_SUCCESS
00:38:18.180 [2980.3196] <2> DbmOdbcView::fetchSigned: (.1) Fetched: 57
00:38:18.180 [2980.3196] <2> DbmOdbcConnect::set_connection_id: -1 -> 57
00:38:18.180 [2980.3196] <2> DbmOdbcConnect::spawnOdbcView: (57) success
00:38:18.180 [2980.3196] <2> getMasterServerKey: Entering
00:38:18.180 [2980.3196] <2> DbmOdbcView::DbmOdbcView: (.2) Entering
00:38:18.180 [2980.3196] <2> DbmOdbcConnect::spawnOdbcView: (57) success
00:38:18.180 [2980.3196] <2> queryMachineKey: Entering
00:38:18.180 [2980.3196] <2> DbmOdbcView::executeSql: (57.2) Executing "SELECT MachineKey FROM EMM_Main.EMM_MachineAlias WITH (READUNCOMMITTED) WHERE MachineNbuType IN (3, 5) AND UPPER(MachineAliasName) = UPPER(?) FOR READ ONLY"
00:38:18.180 [2980.3196] <2> DbmOdbcView::executeSql: Bindings = <'vm08r2'>
00:38:18.195 [2980.3196] <2> DbmOdbcView::executeSql: SQL_SUCCESS
00:38:18.195 [2980.3196] <2> DbmOdbcView::fetchUnsigned: (.2) Fetched: 1000002
00:38:18.195 [2980.3196] <2> queryMachineKey: Fetched key 1000002 for machine name vm08r2 type 3
00:38:18.195 [2980.3196] <2> getMasterServerKey: Got machine key 1000002 for master server vm08r2
00:38:18.195 [2980.3196] <2> DbmOdbcView::~DbmOdbcView: (.2) Exiting
00:38:18.195 [2980.3196] <2> DbmOdbcView::executeSql: (57.1) Executing "SELECT... FROM PEM_Main.PEM_SLP AS SLP, PEM_Main.PEM_SLPDestinations AS SD  WHERE (SLP.SLPName = 'slp2')AND (SLP.MasterServerKey = 1000002) AND SLP.VersionNumber = (SELECT isnull(MAX(VersionNumber), -1) FROM PEM_Main.PEM_SLP WHERE SLPName = 'slp2' AND MasterServerKey = 1000002 )  AND SD.SLPNameKey = SLP.SLPNameKey  ORDER BY SD.SLPIndex ASC "
00:38:18.195 [2980.3196] <2> DbmOdbcView::executeSql: SQL_SUCCESS
00:38:18.195 [2980.3196] <4> fetch_DBM_SLP: About to fetch DBM_SLP
00:38:18.195 [2980.3196] <2> fetch_DBM_SLP: Success fetching DBM_SLP <slp2> Flags <4>
00:38:18.195 [2980.3196] <4> fetch_DBM_SLP: About to fetch DBM_SLP
00:38:18.195 [2980.3196] <2> fetch_DBM_SLP: Success fetching DBM_SLP <slp2> Flags <4>
00:38:18.195 [2980.3196] <4> fetch_DBM_SLP: About to fetch DBM_SLP
00:38:18.195 [2980.3196] <4> fetch_DBM_SLP: No data found when fetching DBM_SLP
00:38:18.195 [2980.3196] <2> DbmSLP::get_DBM_SLP: on exit rc value is <0> 
00:38:18.195 [2980.3196] <2> vnet_in_resilient_network: [vnet_addrinfo.c:8752] ignoring local host 0 0x0
00:38:18.195 [2980.3196] <2> insert_if_not_dup: [vnet_addrinfo.c:5705] ignoring IPv6 link local 0 0x0
00:38:18.195 [2980.3196] <2> vnet_sortaddrs: [vnet_addrinfo.c:3945] sorted addrs: 1 0x1
00:38:18.195 [2980.3196] <2> vnet_get_pref_netconnection: [vnet_addrinfo.c:4776] Local [strong] check, using interface  ANY
00:38:18.195 [2980.3196] <2> async_connect: [vnet_connect.c:1477] connect in progress 1 0x1
00:38:18.195 [2980.3196] <2> async_connect: [vnet_connect.c:1644] connect async CONNECT FROM 10.200.108.193.58807 TO 10.200.108.193.13720 fd = 592
00:38:18.195 [2980.3196] <2> connect_to_service: connect succeeded STATUS (0) SUCCESS FROM 0.0.0.0 TO vm08r2 10.200.108.193 bprd
00:38:18.195 [2980.3196] <2> logconnections: BPRD CONNECT FROM 10.200.108.193.58807 TO 10.200.108.193.13720 fd = 592
00:38:18.195 [2980.3196] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
00:38:18.195 [2980.3196] <2> bprd_read_text_file: Starting to read data
00:38:18.367 [2980.3196] <2> bprd_read_text_file: Read 815 lines and wrote to file C:\Windows\TEMP\ltemp-02980361896698195196000000000-a03196
00:38:18.367 [2980.3196] <2> DbmOdbcView::~DbmOdbcView: (.1) Exiting
00:38:18.367 [2980.3196] <2> DbmOdbcConnect::~DbmOdbcConnect: (57) Exiting
00:38:18.383 [2980.3196] <2> ValidateOnePolicy: Validating schedule Default-Application-Backup
00:38:18.383 [2980.3196] <2> CheckSchedWithSLP: policy name= po9-sql, sched name= Default-Application-Backup, SLP name= slp2, bSLPDoesSnapshots= true, bPolicyDoesSnapshots= true
00:38:18.383 [2980.3196] <2> db_logPolicyImpact: policy po9-sql
00:38:18.383 [2980.3196] <2> db_logPolicyImpact:     id = 1543 old value = *NULL* new value = slp2
00:38:18.383 [2980.3196] <2> db_logPolicyImpact:     id = 1545 old value = Default-Application-Backup new value = slp2
00:38:18.383 [2980.3196] <2> ValidateOnePolicy: SLP validation of policy po9-sql finished, retval= 0, conflicts= yes
00:38:18.383 [2980.3196] <2> MarshalImpactListbuffer: Destination count was 2 
00:38:18.383 [2980.3196] <2> MarshalImpactListbuffer: remaining bytes in buffer: 4929
00:38:18.383 [2980.3196] <2> ss_db: query return value = 1537(Backup policy and storage lifecycle policy have conflicting configurations)
00:38:18.383 [2980.3196] <2> process_request: request complete: exit status 1537 Backup policy and storage lifecycle policy have conflicting configurations; query type: 296
00:38:26.258 [1948.4772] <2> listen_loop: socket fd from accept() is 532
00:38:26.258 [1948.4772] <2> listen_loop: Locale info: message=zh, ctype=zh, time=zh, collate=zh, num=zh
00:38:26.742 [3960.792] <2> getIDIRSTRUCT: ?
00:38:26.742 [3960.792] <2> logconnections: BPDBM ACCEPT FROM 10.200.108.193.58814 TO 10.200.108.193.13721 fd = 532
00:38:26.742 [3960.792] <2> init_resilient_cache: [vnet_nbrntd.c:869] Initialize resilient cache. 0 0x0
00:38:26.742 [3960.792] <2> vnet_pcache_init_table: [vnet_private.c:235] starting cache size 200 0xc8
00:38:26.742 [3960.792] <2> vnet_cached_getnameinfo: [vnet_addrinfo.c:1895] found via getnameinfo OUR_HOST=vm08r2 IPSTR=10.200.108.193
00:38:26.742 [3960.792] <2> bpdbm: VERBOSE = 5
00:38:26.742 [3960.792] <2> db_getrequest_vxss: Entering
00:38:26.742 [3960.792] <8> vnet_check_vxss_server_magic: [vnet_vxss_helper.c:495] VxSS magic 1041669 0xfe505
00:38:26.742 [3960.792] <8> vnet_check_vxss_server_magic: [vnet_vxss_helper.c:496] remote_vxss 296 0x128
00:38:26.742 [3960.792] <8> vnet_check_vxss_server_magic: [vnet_vxss_helper.c:538] Ignoring VxSS authentication 2 0x2
00:38:26.758 [3960.792] <2> mlic_get_nb_features: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.461: license.txt reread = <Thu Jan 01 08:00:00 1970
>
00:38:26.758 [3960.792] <2> LOCAL CLASS_ATT_DEFS: Product ID = 6
00:38:26.758 [3960.792] <2> mlic_check_product_id_line: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.526: matched product ID = 6 0x00000006
00:38:26.758 [3960.792] <2> mlic_check_product_id_line: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.529: mis-matched old product ID = 6 0x00000006
00:38:26.758 [3960.792] <2> mlic_check_product_id_line: D:\NB\NB_7.5.0.4\src\licensing\libminlicense\minlicfile.c.530: mis-matched new product ID = 7 0x00000007
00:38:26.758 [3960.792] <2> adjust_Vnydef: Change for policy type 26, was 2, now 1
00:38:26.758 [3960.792] <2> ss_db: Q_SS_ONEPOLICY_IMPACT
00:38:26.758 [3960.792] <4> TZ: Recv Timezone offset=-28800-local=-28800
00:38:26.758 [3960.792] <2> db_logclassrec: qtype=0 policy=po9-sql, name=?, options=0x0
00:38:26.758 [3960.792] <2> db_logclassrec: names is NULL
00:38:26.758 [3960.792] <2> db_logclassinfo: client type: 15, follow nfs mounts: 0
00:38:26.758 [3960.792] <2> db_logclassinfo: cross mount points: 0
00:38:26.758 [3960.792] <2> db_logclassinfo: client compress: 0, client encrypt: 0
00:38:26.758 [3960.792] <2> db_logclassinfo: priority: 0, disaster recovery: 0, maxjobs/policy: 2147483647
00:38:26.758 [3960.792] <2> db_logclassinfo: collect bmr info: no
00:38:26.758 [3960.792] <2> db_logclassinfo: max frag size: 0, active: yes
00:38:26.758 [3960.792] <2> db_logclassinfo: classID: F2DB9A69C1924052976A762BBFC0472A
00:38:26.758 [3960.792] <2> db_logclassinfo: collect tir: 0,  proxy client: ?
00:38:26.758 [3960.792] <2> db_logclassinfo: enable PFI: 1
00:38:26.758 [3960.792] <2> db_logclassinfo: extended security information: no
00:38:26.758 [3960.792] <2> db_logclassinfo: individual file restore from raw: no
00:38:26.758 [3960.792] <2> db_logclassinfo: block incremental: no
00:38:26.758 [3960.792] <2> db_logclassinfo: multistreaming: no
00:38:26.758 [3960.792] <2> db_logclassinfo: effective date: 0
00:38:26.758 [3960.792] <2> db_logclassinfo: number of copies: 1
00:38:26.758 [3960.792] <2> db_logclassinfo: fail on error (0): 0 0 0 0 0 0 0 0 0 0
00:38:26.758 [3960.792] <2> db_logclassinfo: checkpoint enabled: no interval: 0 minutes
00:38:26.758 [3960.792] <2> db_logclassinfo: perform snapshots: yes
00:38:26.758 [3960.792] <2> db_logclassinfo: backup copy: Standard (0)
00:38:26.758 [3960.792] <2> db_logclassinfo: job_subtype backup: 0
00:38:26.758 [3960.792] <2> db_logclassinfo: offhost backup: no
00:38:26.758 [3960.792] <2> db_logclassinfo: enable instant recovery: yes
00:38:26.758 [3960.792] <2> db_logclassinfo: use alternate client: no
00:38:26.758 [3960.792] <2> db_logclassinfo: alternate client name: ?
00:38:26.758 [3960.792] <2> db_logclassinfo: use virtual machine: None (0)
00:38:26.758 [3960.792] <2> db_logclassinfo: use data mover: no
00:38:26.758 [3960.792] <2> db_logclassinfo: data mover type: Media-Server-Copy (2)
00:38:26.758 [3960.792] <2> db_logclassinfo: snapshot method: VSS
00:38:26.758 [3960.792] <2> db_logclassinfo: snapshot arguments: prov_type=0,snap_attr=0,max_snapshots=1
00:38:26.758 [3960.792] <2> db_logclassinfo: keyword: ?
00:38:26.758 [3960.792] <2> db_logclassinfo: residence: slp2 - - - - - - - - -
00:38:26.758 [3960.792] <2> db_logclassinfo: pool: NetBackup - - - - - - - - -
00:38:26.758 [3960.792] <2> db_logclassinfo: data class: -
00:38:26.758 [3960.792] <2> db_logclassinfo: backup command: ?
00:38:26.758 [3960.792] <2> db_logclassinfo: restore command: ?
00:38:26.758 [3960.792] <2> db_logclassinfo: share group: *ANY*
00:38:26.758 [3960.792] <2> db_logclassinfo: residence is storage service: yes
00:38:26.758 [3960.792] <2> db_logclassinfo: granular restore info: no
00:38:26.758 [3960.792] <2> db_logclassinfo: generation: 0
00:38:26.758 [3960.792] <2> db_logclassinfo: ignore client direct: no
00:38:26.758 [3960.792] <2> db_logclassinfo: use fast backup: no
00:38:26.758 [3960.792] <2> db_logclassinfo: Hyper-V server: ? (0000000000000000)
00:38:26.758 [3960.792] <2> db_logclassinfo: exchange_source: 3
00:38:26.758 [3960.792] <2> db_logclassinfo: enable metadata indexing: no
00:38:26.758 [3960.792] <2> db_logclassinfo: use application discovery: no
00:38:26.758 [3960.792] <2> db_logclassinfo: application discovery time: 28800
00:38:26.758 [3960.792] <2> db_logclassinfo: index server name: ?
00:38:26.758 [3960.792] <2> db_logclassrec: clients is NULL
00:38:26.758 [3960.792] <2> db_logclassrec: include is NULL
00:38:26.758 [3960.792] <2> db_logclassrec: exclude is NULL
00:38:26.758 [3960.792] <2> db_logschedrec: ->label=f type=0 frequency=604800
00:38:26.758 [3960.792] <2> db_logschedrec: incr type=0
00:38:26.758 [3960.792] <2> db_logschedrec: stage priority=-1
00:38:26.758 [3960.792] <2> db_logschedrec: alt read host=?
00:38:26.758 [3960.792] <2> db_logschedrec: day[0]: open=0000000000, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: day[1]: open=0000000000, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: day[2]: open=0000000000, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: day[3]: open=0000000000, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: day[4]: open=0000000000, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: day[5]: open=0000000000, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: day[6]: open=0000000000, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: residence: - - - - - - - - - -
00:38:26.758 [3960.792] <2> db_logschedrec: pool: - - - - - - - - - -
00:38:26.758 [3960.792] <2> db_logschedrec: max frag size: 0
00:38:26.758 [3960.792] <2> db_logschedrec: max mpx: 1
00:38:26.758 [3960.792] <2> db_logschedrec: number of copies: 0
00:38:26.758 [3960.792] <2> db_logschedrec: fail on error (0): 0 0 0 0 0 0 0 0 0 0
00:38:26.758 [3960.792] <2> db_logschedrec: calendar: 0
00:38:26.758 [3960.792] <2> db_logschedrec: Null schedule object
00:38:26.758 [3960.792] <2> db_logschedrec: s_checksum_validation: 0
00:38:26.758 [3960.792] <2> db_logschedrec: s_fast_recovery: 0
00:38:26.758 [3960.792] <2> db_logschedrec: unused_window: open=0, duration=0
00:38:26.758 [3960.792] <2> db_logschedrec: sched_indexing=0
00:38:26.758 [3960.792] <2> db_logclassrec: Normal Policy
00:38:26.758 [3960.792] <2> db_logclassrec: protocol version: 750000
00:38:26.758 [3960.792] <2> db_logclassrec: TZ offset: 144000
00:38:26.758 [3960.792] <2> db_logclassrec: audit_reason: ?
00:38:26.758 [3960.792] <2> ValidateOnePolicy: SLP validation of policy po9-sql
00:38:26.758 [3960.792] <2> DbmSLP::get_DBM_SLP: Entering
00:38:26.758 [3960.792] <2> DbmOdbcConnect::DbmOdbcConnect: ENTERING
00:38:26.758 [3960.792] <2> ReadVxDBMS_ConfFile: Acquiring mutex
00:38:26.758 [3960.792] <2> ReadVxDBMS_ConfFile: Acquiring read lock on C:\Program Files\Veritas\NetBackupDB\data\vxdbms_conf.lock
00:38:26.758 [3960.792] <2> ReadVxDBMS_ConfFile: Acquired read lock on C:\Program Files\Veritas\NetBackupDB\data\vxdbms_conf.lock successfully with fd (464)
00:38:26.758 [3960.792] <2> ReadVxDBMS_ConfFile: unlocking on fd (464) for C:\Program Files\Veritas\NetBackupDB\data\vxdbms_conf.lock
00:38:26.758 [3960.792] <2> ReadVxDBMS_ConfFile: Releasing mutex
00:38:26.773 [3960.792] <2> DbmOdbcConnect::initialize_odbc: Connecting to a database. connect_string=<DRIVER=NB SQL Anywhere;PROWS=1000;PBUF=8m;CS=utf8;UID=DBM_MAIN;PWD=******;LINKS=shmem,tcpip{PORT=13785};ENG=NB_vm08r2;DBN=NBDB;CON=DBM_3960_1>
00:38:26.773 [3960.792] <2> DbmOdbcConnect::setIsolationLevel: (-1) Isolation Level=<32> (SNAPSHOT)
00:38:26.773 [3960.792] <2> DbmOdbcView::DbmOdbcView: (.1) Entering
00:38:26.773 [3960.792] <2> DbmOdbcView::executeSql: (-1.1) Executing "SELECT @@SPID"
00:38:26.773 [3960.792] <2> DbmOdbcView::executeSql: SQL_SUCCESS
00:38:26.773 [3960.792] <2> DbmOdbcView::fetchSigned: (.1) Fetched: 58
00:38:26.773 [3960.792] <2> DbmOdbcConnect::set_connection_id: -1 -> 58
00:38:26.773 [3960.792] <2> DbmOdbcConnect::spawnOdbcView: (58) success
00:38:26.773 [3960.792] <2> getMasterServerKey: Entering
00:38:26.773 [3960.792] <2> DbmOdbcView::DbmOdbcView: (.2) Entering
00:38:26.773 [3960.792] <2> DbmOdbcConnect::spawnOdbcView: (58) success
00:38:26.773 [3960.792] <2> queryMachineKey: Entering
00:38:26.773 [3960.792] <2> DbmOdbcView::executeSql: (58.2) Executing "SELECT MachineKey FROM EMM_Main.EMM_MachineAlias WITH (READUNCOMMITTED) WHERE MachineNbuType IN (3, 5) AND UPPER(MachineAliasName) = UPPER(?) FOR READ ONLY"
00:38:26.773 [3960.792] <2> DbmOdbcView::executeSql: Bindings = <'vm08r2'>
00:38:26.773 [3960.792] <2> DbmOdbcView::executeSql: SQL_SUCCESS
00:38:26.773 [3960.792] <2> DbmOdbcView::fetchUnsigned: (.2) Fetched: 1000002
00:38:26.773 [3960.792] <2> queryMachineKey: Fetched key 1000002 for machine name vm08r2 type 3
00:38:26.773 [3960.792] <2> getMasterServerKey: Got machine key 1000002 for master server vm08r2
00:38:26.773 [3960.792] <2> DbmOdbcView::~DbmOdbcView: (.2) Exiting
00:38:26.773 [3960.792] <2> DbmOdbcView::executeSql: (58.1) Executing "SELECT... FROM PEM_Main.PEM_SLP AS SLP, PEM_Main.PEM_SLPDestinations AS SD  WHERE (SLP.SLPName = 'slp2')AND (SLP.MasterServerKey = 1000002) AND SLP.VersionNumber = (SELECT isnull(MAX(VersionNumber), -1) FROM PEM_Main.PEM_SLP WHERE SLPName = 'slp2' AND MasterServerKey = 1000002 )  AND SD.SLPNameKey = SLP.SLPNameKey  ORDER BY SD.SLPIndex ASC "
00:38:26.773 [3960.792] <2> DbmOdbcView::executeSql: SQL_SUCCESS
00:38:26.773 [3960.792] <4> fetch_DBM_SLP: About to fetch DBM_SLP
00:38:26.773 [3960.792] <2> fetch_DBM_SLP: Success fetching DBM_SLP <slp2> Flags <4>
00:38:26.773 [3960.792] <4> fetch_DBM_SLP: About to fetch DBM_SLP
00:38:26.773 [3960.792] <2> fetch_DBM_SLP: Success fetching DBM_SLP <slp2> Flags <4>
00:38:26.773 [3960.792] <4> fetch_DBM_SLP: About to fetch DBM_SLP
00:38:26.773 [3960.792] <4> fetch_DBM_SLP: No data found when fetching DBM_SLP
00:38:26.773 [3960.792] <2> DbmSLP::get_DBM_SLP: on exit rc value is <0> 
00:38:26.773 [3960.792] <2> vnet_in_resilient_network: [vnet_addrinfo.c:8752] ignoring local host 0 0x0
00:38:26.773 [3960.792] <2> insert_if_not_dup: [vnet_addrinfo.c:5705] ignoring IPv6 link local 0 0x0
00:38:26.773 [3960.792] <2> vnet_sortaddrs: [vnet_addrinfo.c:3945] sorted addrs: 1 0x1
00:38:26.773 [3960.792] <2> vnet_get_pref_netconnection: [vnet_addrinfo.c:4776] Local [strong] check, using interface  ANY
00:38:26.789 [3960.792] <2> async_connect: [vnet_connect.c:1477] connect in progress 1 0x1
00:38:26.789 [3960.792] <2> async_connect: [vnet_connect.c:1644] connect async CONNECT FROM 10.200.108.193.58815 TO 10.200.108.193.13720 fd = 592
00:38:26.789 [3960.792] <2> connect_to_service: connect succeeded STATUS (0) SUCCESS FROM 0.0.0.0 TO vm08r2 10.200.108.193 bprd
00:38:26.789 [3960.792] <2> logconnections: BPRD CONNECT FROM 10.200.108.193.58815 TO 10.200.108.193.13720 fd = 592
00:38:26.789 [3960.792] <8> vnet_check_vxss_client_magic_with_info: [vnet_vxss_helper.c:871] Ignoring VxSS authentication 2 0x2
00:38:26.789 [3960.792] <2> bprd_read_text_file: Starting to read data
00:38:26.867 [3960.792] <2> bprd_read_text_file: Read 815 lines and wrote to file C:\Windows\TEMP\ltemp-03960361896706773792000000000-a00792
00:38:26.867 [3960.792] <2> DbmOdbcView::~DbmOdbcView: (.1) Exiting
00:38:26.867 [3960.792] <2> DbmOdbcConnect::~DbmOdbcConnect: (58) Exiting
00:38:26.883 [3960.792] <2> ValidateOnePolicy: Validating schedule f
00:38:26.883 [3960.792] <2> CheckSchedWithSLP: policy name= po9-sql, sched name= f, SLP name= slp2, bSLPDoesSnapshots= true, bPolicyDoesSnapshots= true
00:38:26.883 [3960.792] <2> db_logPolicyImpact: policy po9-sql
00:38:26.883 [3960.792] <2> db_logPolicyImpact:     id = 1543 old value = *NULL* new value = slp2
00:38:26.883 [3960.792] <2> ValidateOnePolicy: SLP validation of policy po9-sql finished, retval= 0, conflicts= yes
00:38:26.883 [3960.792] <2> MarshalImpactListbuffer: Destination count was 1 
00:38:26.883 [3960.792] <2> MarshalImpactListbuffer: remaining bytes in buffer: 4967
00:38:26.883 [3960.792] <2> ss_db: query return value = 1537(Backup policy and storage lifecycle policy have conflicting configurations)
00:38:26.883 [3960.792] <2> process_request: request complete: exit status 1537 Backup policy and storage lifecycle policy have conflicting configurations; query type: 296
00:38:33.273 [1948.4772] <2> insert_if_not_dup: [vnet_addrinfo.c:5705] ignoring IPv6 link local 0 0x0