NDMP incremental backup seems not work on NetApp SMTape
79 views
Skip to first unread message
Wenjun Shen
Jul 7, 2021, 3:21:34 AM7/7/21
to bareos...@googlegroups.com
Hi,
I'm using ndmp with smtape engine to backup a netapp nas filer.
Full backup is ok, but the incremental backup seems no incremental because the data backuped is the same as Full backup.
Here's some logs of bareos-dir and netapp.
07-Jul 04:59 bareos-dir JobId 38: Start NDMP Backup JobId 38, Job=BackupNDMPSMTape.2021-07-07_04.59.37_12
07-Jul 04:59 bareos-dir JobId 38: Connected Storage daemon at 172.16.10.140:9103, encryption: TLS_CHACHA20_POLY1305_SHA256 TLSv1.3
07-Jul 04:59 bareos-dir JobId 38: Using Device "FileStorage" to write.
07-Jul 04:59 bareos-dir JobId 38: >C NDMP0_NOTIFY_CONNECTED 1
07-Jul 04:59 bareos-dir JobId 38: reason=NDMP0_CONNECTED protocol_version=4 text_reason='Connection successful'
07-Jul 04:59 bareos-dir JobId 38: C> NDMP0_CONNECT_OPEN 1
07-Jul 04:59 bareos-dir JobId 38: version=4
07-Jul 04:59 bareos-dir JobId 38: >R NDMP0_CONNECT_OPEN 1 (2)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP0_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_CONFIG_GET_AUTH_ATTR 2
07-Jul 04:59 bareos-dir JobId 38: auth_type=NDMP4_AUTH_MD5
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_CONFIG_GET_AUTH_ATTR 2 (3)
07-Jul 04:59 bareos-dir JobId 38: <<unimplemented pp>>
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_CONNECT_CLIENT_AUTH 3
07-Jul 04:59 bareos-dir JobId 38: auth_type=NDMP4_AUTH_MD5 auth_id=root
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_CONNECT_CLIENT_AUTH 3 (4)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: >C NDMP0_NOTIFY_CONNECTED 1
07-Jul 04:59 bareos-dir JobId 38: reason=NDMP0_CONNECTED protocol_version=4 text_reason='Hello'
07-Jul 04:59 bareos-dir JobId 38: C> NDMP0_CONNECT_OPEN 1
07-Jul 04:59 bareos-dir JobId 38: version=4
07-Jul 04:59 bareos-dir JobId 38: >R NDMP0_CONNECT_OPEN 1 (2)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP0_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_CONNECT_CLIENT_AUTH 2
07-Jul 04:59 bareos-dir JobId 38: auth_type=NDMP4_AUTH_TEXT auth_id=root
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_CONNECT_CLIENT_AUTH 2 (3)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: ndmca_connect_tape_agent: 0 0x7ff6c001bb30
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_MOVER_SET_RECORD_SIZE 3
07-Jul 04:59 bareos-dir JobId 38: len=262144
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_MOVER_SET_RECORD_SIZE 3 (4)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: Opening tape drive NKGO-AALJ-CHPP-GMOB-POMJ-MCEH-BJDL-OMHK@/vol/vol0%3 read/write
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_TAPE_OPEN 4
07-Jul 04:59 bareos-dir JobId 38: device='NKGO-AALJ-CHPP-GMOB-POMJ-MCEH-BJDL-OMHK@/vol/vol0%3' mode=NDMP4_TAPE_RDWR_MODE
07-Jul 04:59 bareos-sd JobId 38: Volume "Incremental-0005" previously written, moving to end of data.
07-Jul 04:59 bareos-sd JobId 38: Ready to append to end of Volume "Incremental-0005" size=4211308270
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_TAPE_OPEN 4 (5)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: Commanding tape drive to rewind
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_TAPE_MTIO 5
07-Jul 04:59 bareos-dir JobId 38: op=NDMP4_MTIO_REW count=1
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_TAPE_MTIO 5 (6)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR resid_count=0
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_MOVER_SET_WINDOW 6
07-Jul 04:59 bareos-dir JobId 38: offset=0 length=-1
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_MOVER_SET_WINDOW 6 (7)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_MOVER_LISTEN 7
07-Jul 04:59 bareos-dir JobId 38: mode=NDMP4_MOVER_MODE_READ addr_type=NDMP4_ADDR_TCP
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_MOVER_LISTEN 7 (8)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_DATA_CONNECT 4
07-Jul 04:59 bareos-dir JobId 38: addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_DATA_CONNECT 4 (5)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_DATA_START_BACKUP 5
07-Jul 04:59 bareos-dir JobId 38: butype_name='smtape' n_env=7
07-Jul 04:59 bareos-dir JobId 38: env[0] name='HIST' value='n'
07-Jul 04:59 bareos-dir JobId 38: env[1] name='TYPE' value='smtape'
07-Jul 04:59 bareos-dir JobId 38: env[2] name='LEVEL' value='3'
07-Jul 04:59 bareos-dir JobId 38: env[3] name='UPDATE' value='y'
07-Jul 04:59 bareos-dir JobId 38: env[4] name='FILESYSTEM' value='/vol/vol0'
07-Jul 04:59 bareos-dir JobId 38: env[5] name='SMTAPE_DELETE_SNAPSHOT' value='N'
07-Jul 04:59 bareos-dir JobId 38: env[6] name='DATA_BLOCK_SIZE' value='240'
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_DATA_START_BACKUP 5 (6)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 04:59 bareos-dir JobId 38: Waiting for operation to start
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_DATA_GET_STATE 6
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_DATA_GET_STATE 6 (7)
07-Jul 04:59 bareos-dir JobId 38: unsupp=3 error=NDMP4_NO_ERR op=NDMP4_DATA_OP_BACKUP
07-Jul 04:59 bareos-dir JobId 38: state=NDMP4_DATA_STATE_ACTIVE
07-Jul 04:59 bareos-dir JobId 38: halt_reason=NDMP4_DATA_HALT_NA
07-Jul 04:59 bareos-dir JobId 38: bytes_processed=0 est_bytes_remain=0
07-Jul 04:59 bareos-dir JobId 38: est_time_remain=0 data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 04:59 bareos-dir JobId 38: read_offset=0 read_length=0
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_MOVER_GET_STATE 8
07-Jul 04:59 bareos-dir JobId 38: >C NDMP4_LOG_MESSAGE 9
07-Jul 04:59 bareos-dir JobId 38: log_type=NDMP4_LOG_DEBUG id=1625633981 message='mover going active'
07-Jul 04:59 bareos-dir JobId 38: Async request NDMP4_LOG_MESSAGE
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_MOVER_GET_STATE 8 (10)
07-Jul 04:59 bareos-dir JobId 38: error=NDMP4_NO_ERR state=NDMP4_MOVER_STATE_ACTIVE
07-Jul 04:59 bareos-dir JobId 38: pause_reason=NDMP4_MOVER_PAUSE_NA
07-Jul 04:59 bareos-dir JobId 38: halt_reason=NDMP4_MOVER_HALT_NA
07-Jul 04:59 bareos-dir JobId 38: record_size=262144 record_num=0 bytes_moved=0
07-Jul 04:59 bareos-dir JobId 38: seek=0 to_read=0 win_off=0 win_len=-1
07-Jul 04:59 bareos-dir JobId 38: data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 04:59 bareos-dir JobId 38: C> NDMP4_TAPE_GET_STATE 9
07-Jul 04:59 bareos-dir JobId 38: >R NDMP4_TAPE_GET_STATE 9 (11)
07-Jul 04:59 bareos-dir JobId 38: unsupp=30 error=NDMP4_NO_ERR flags=0x0 file_num=0
07-Jul 04:59 bareos-dir JobId 38: soft_errors=0 block_size=0 blockno=0
07-Jul 04:59 bareos-dir JobId 38: total_space=-1 space_remain=-1
07-Jul 04:59 bareos-dir JobId 38: Operation started
07-Jul 04:59 bareos-dir JobId 38: Monitoring backup
07-Jul 04:59 bareos-dir JobId 38: mon_wait_for_something() entered
07-Jul 04:59 bareos-dir JobId 38: >C NDMP4_LOG_MESSAGE 8
07-Jul 04:59 bareos-dir JobId 38: log_type=NDMP4_LOG_NORMAL id=1 message='DUMP_DATE is '129-189311'
'
07-Jul 04:59 bareos-dir JobId 38: LOG_MESSAGE: 'DUMP_DATE is '129-189311''
07-Jul 04:59 bareos-dir JobId 38: >C NDMP4_LOG_MESSAGE 9
07-Jul 04:59 bareos-dir JobId 38: log_type=NDMP4_LOG_NORMAL id=2 message='SMTAPE_BACKUP_SET_ID is '395f2509-dee1-11eb-8696-123478563412'
'
07-Jul 04:59 bareos-dir JobId 38: LOG_MESSAGE: 'SMTAPE_BACKUP_SET_ID is '395f2509-dee1-11eb-8696-123478563412''
07-Jul 05:00 bareos-dir JobId 38: mon_wait_for_something() happened, resid=0
07-Jul 05:00 bareos-dir JobId 38: C> NDMP4_DATA_GET_STATE 7
07-Jul 05:00 bareos-dir JobId 38: >R NDMP4_DATA_GET_STATE 7 (10)
07-Jul 05:00 bareos-dir JobId 38: unsupp=3 error=NDMP4_NO_ERR op=NDMP4_DATA_OP_BACKUP
07-Jul 05:00 bareos-dir JobId 38: state=NDMP4_DATA_STATE_ACTIVE
07-Jul 05:00 bareos-dir JobId 38: halt_reason=NDMP4_DATA_HALT_NA
07-Jul 05:00 bareos-dir JobId 38: bytes_processed=722145280 est_bytes_remain=0
07-Jul 05:00 bareos-dir JobId 38: est_time_remain=0 data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:00 bareos-dir JobId 38: read_offset=0 read_length=0
07-Jul 05:00 bareos-dir JobId 38: C> NDMP4_MOVER_GET_STATE 10
07-Jul 05:00 bareos-dir JobId 38: >R NDMP4_MOVER_GET_STATE 10 (12)
07-Jul 05:00 bareos-dir JobId 38: error=NDMP4_NO_ERR state=NDMP4_MOVER_STATE_ACTIVE
07-Jul 05:00 bareos-dir JobId 38: pause_reason=NDMP4_MOVER_PAUSE_NA
07-Jul 05:00 bareos-dir JobId 38: halt_reason=NDMP4_MOVER_HALT_NA
07-Jul 05:00 bareos-dir JobId 38: record_size=262144 record_num=2757 bytes_moved=722731008
07-Jul 05:00 bareos-dir JobId 38: seek=0 to_read=0 win_off=0 win_len=-1
07-Jul 05:00 bareos-dir JobId 38: data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:00 bareos-dir JobId 38: C> NDMP4_TAPE_GET_STATE 11
07-Jul 05:00 bareos-dir JobId 38: >R NDMP4_TAPE_GET_STATE 11 (13)
07-Jul 05:00 bareos-dir JobId 38: unsupp=30 error=NDMP4_NO_ERR flags=0x0 file_num=0
07-Jul 05:00 bareos-dir JobId 38: soft_errors=0 block_size=0 blockno=2761
07-Jul 05:00 bareos-dir JobId 38: total_space=-1 space_remain=-1
07-Jul 05:00 bareos-dir JobId 38: DATA: bytes 705220KB MOVER: written 705792KB record 2757
07-Jul 05:00 bareos-dir JobId 38: mon_wait_for_something() entered
07-Jul 05:00 bareos-dir JobId 38: mon_wait_for_something() happened, resid=0
07-Jul 05:00 bareos-dir JobId 38: C> NDMP4_DATA_GET_STATE 8
07-Jul 05:00 bareos-dir JobId 38: >R NDMP4_DATA_GET_STATE 8 (11)
07-Jul 05:00 bareos-dir JobId 38: unsupp=3 error=NDMP4_NO_ERR op=NDMP4_DATA_OP_BACKUP
07-Jul 05:00 bareos-dir JobId 38: state=NDMP4_DATA_STATE_ACTIVE
07-Jul 05:00 bareos-dir JobId 38: halt_reason=NDMP4_DATA_HALT_NA
07-Jul 05:00 bareos-dir JobId 38: bytes_processed=1326485504 est_bytes_remain=0
07-Jul 05:00 bareos-dir JobId 38: est_time_remain=0 data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:00 bareos-dir JobId 38: read_offset=0 read_length=0
07-Jul 05:00 bareos-dir JobId 38: C> NDMP4_MOVER_GET_STATE 12
07-Jul 05:00 bareos-dir JobId 38: >R NDMP4_MOVER_GET_STATE 12 (14)
07-Jul 05:00 bareos-dir JobId 38: error=NDMP4_NO_ERR state=NDMP4_MOVER_STATE_ACTIVE
07-Jul 05:00 bareos-dir JobId 38: pause_reason=NDMP4_MOVER_PAUSE_NA
07-Jul 05:00 bareos-dir JobId 38: halt_reason=NDMP4_MOVER_HALT_NA
07-Jul 05:00 bareos-dir JobId 38: record_size=262144 record_num=5062 bytes_moved=1326972928
07-Jul 05:00 bareos-dir JobId 38: seek=0 to_read=0 win_off=0 win_len=-1
07-Jul 05:00 bareos-dir JobId 38: data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:00 bareos-dir JobId 38: C> NDMP4_TAPE_GET_STATE 13
07-Jul 05:00 bareos-dir JobId 38: >R NDMP4_TAPE_GET_STATE 13 (15)
07-Jul 05:00 bareos-dir JobId 38: unsupp=30 error=NDMP4_NO_ERR flags=0x0 file_num=0
07-Jul 05:00 bareos-dir JobId 38: soft_errors=0 block_size=0 blockno=5067
07-Jul 05:00 bareos-dir JobId 38: total_space=-1 space_remain=-1
07-Jul 05:00 bareos-dir JobId 38: DATA: bytes 1295396KB MOVER: written 1295872KB record 5062
07-Jul 05:00 bareos-dir JobId 38: mon_wait_for_something() entered
07-Jul 05:01 bareos-dir JobId 38: mon_wait_for_something() happened, resid=-1
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_DATA_GET_STATE 9
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_DATA_GET_STATE 9 (12)
07-Jul 05:01 bareos-dir JobId 38: unsupp=3 error=NDMP4_NO_ERR op=NDMP4_DATA_OP_BACKUP
07-Jul 05:01 bareos-dir JobId 38: state=NDMP4_DATA_STATE_ACTIVE
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_DATA_HALT_NA
07-Jul 05:01 bareos-dir JobId 38: bytes_processed=1966911488 est_bytes_remain=0
07-Jul 05:01 bareos-dir JobId 38: est_time_remain=0 data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:01 bareos-dir JobId 38: read_offset=0 read_length=0
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_MOVER_GET_STATE 14
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_MOVER_GET_STATE 14 (16)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR state=NDMP4_MOVER_STATE_ACTIVE
07-Jul 05:01 bareos-dir JobId 38: pause_reason=NDMP4_MOVER_PAUSE_NA
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_MOVER_HALT_NA
07-Jul 05:01 bareos-dir JobId 38: record_size=262144 record_num=7508 bytes_moved=1968177152
07-Jul 05:01 bareos-dir JobId 38: seek=0 to_read=0 win_off=0 win_len=-1
07-Jul 05:01 bareos-dir JobId 38: data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_TAPE_GET_STATE 15
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_TAPE_GET_STATE 15 (17)
07-Jul 05:01 bareos-dir JobId 38: unsupp=30 error=NDMP4_NO_ERR flags=0x0 file_num=0
07-Jul 05:01 bareos-dir JobId 38: soft_errors=0 block_size=0 blockno=7508
07-Jul 05:01 bareos-dir JobId 38: total_space=-1 space_remain=-1
07-Jul 05:01 bareos-dir JobId 38: DATA: bytes 1920812KB MOVER: written 1922048KB record 7508
07-Jul 05:01 bareos-dir JobId 38: mon_wait_for_something() entered
07-Jul 05:01 bareos-dir JobId 38: >C NDMP4_NOTIFY_MOVER_HALTED 18
07-Jul 05:01 bareos-dir JobId 38: reason=NDMP4_MOVER_HALT_CONNECT_CLOSED
07-Jul 05:01 bareos-dir JobId 38: mon_wait_for_something() happened, resid=8
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_DATA_GET_STATE 10
07-Jul 05:01 bareos-dir JobId 38: >C NDMP4_NOTIFY_DATA_HALTED 13
07-Jul 05:01 bareos-dir JobId 38: reason=NDMP4_DATA_HALT_SUCCESSFUL
07-Jul 05:01 bareos-dir JobId 38: Async request NDMP4_NOTIFY_DATA_HALTED
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_DATA_GET_STATE 10 (14)
07-Jul 05:01 bareos-dir JobId 38: unsupp=3 error=NDMP4_NO_ERR op=NDMP4_DATA_OP_BACKUP
07-Jul 05:01 bareos-dir JobId 38: state=NDMP4_DATA_STATE_HALTED
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_DATA_HALT_SUCCESSFUL
07-Jul 05:01 bareos-dir JobId 38: bytes_processed=2637066240 est_bytes_remain=0
07-Jul 05:01 bareos-dir JobId 38: est_time_remain=0 data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:01 bareos-dir JobId 38: read_offset=0 read_length=0
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_MOVER_GET_STATE 16
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_MOVER_GET_STATE 16 (19)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR state=NDMP4_MOVER_STATE_HALTED
07-Jul 05:01 bareos-dir JobId 38: pause_reason=NDMP4_MOVER_PAUSE_NA
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_MOVER_HALT_CONNECT_CLOSED
07-Jul 05:01 bareos-dir JobId 38: record_size=262144 record_num=10060 bytes_moved=2637168640
07-Jul 05:01 bareos-dir JobId 38: seek=0 to_read=0 win_off=0 win_len=-1
07-Jul 05:01 bareos-dir JobId 38: data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_TAPE_GET_STATE 17
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_TAPE_GET_STATE 17 (20)
07-Jul 05:01 bareos-dir JobId 38: unsupp=30 error=NDMP4_NO_ERR flags=0x0 file_num=0
07-Jul 05:01 bareos-dir JobId 38: soft_errors=0 block_size=0 blockno=10060
07-Jul 05:01 bareos-dir JobId 38: total_space=-1 space_remain=-1
07-Jul 05:01 bareos-dir JobId 38: DATA: bytes 2575260KB MOVER: written 2575360KB record 10060
07-Jul 05:01 bareos-dir JobId 38: Operation done, cleaning up
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_DATA_GET_ENV 11
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_DATA_GET_ENV 11 (15)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR n_env=13
07-Jul 05:01 bareos-dir JobId 38: [0] name='SMTAPE_BACKUP_SET_ID' value='395f2509-dee1-11eb-8696-123478563412'
07-Jul 05:01 bareos-dir JobId 38: [1] name='DUMP_DATE' value='129-189311'
07-Jul 05:01 bareos-dir JobId 38: [2] name='BASE_DATE' value='-1'
07-Jul 05:01 bareos-dir JobId 38: [3] name='PATHNAME_SEPARATOR' value='/'
07-Jul 05:01 bareos-dir JobId 38: [4] name='NDMP_VERSION' value='4'
07-Jul 05:01 bareos-dir JobId 38: [5] name='IGNORE_CTIME' value='Y'
07-Jul 05:01 bareos-dir JobId 38: [6] name='DATA_BLOCK_SIZE' value='240'
07-Jul 05:01 bareos-dir JobId 38: [7] name='SMTAPE_DELETE_SNAPSHOT' value='N'
07-Jul 05:01 bareos-dir JobId 38: [8] name='FILESYSTEM' value='/vol/vol0'
07-Jul 05:01 bareos-dir JobId 38: [9] name='UPDATE' value='Y'
07-Jul 05:01 bareos-dir JobId 38: [10] name='LEVEL' value='3'
07-Jul 05:01 bareos-dir JobId 38: [11] name='TYPE' value='smtape'
07-Jul 05:01 bareos-dir JobId 38: [12] name='HIST' value='N'
07-Jul 05:01 bareos-dir JobId 38: Waiting for operation to halt
07-Jul 05:01 bareos-dir JobId 38: mon_wait_for_something() entered
07-Jul 05:01 bareos-dir JobId 38: mon_wait_for_something() happened, resid=2
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_DATA_GET_STATE 12
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_DATA_GET_STATE 12 (16)
07-Jul 05:01 bareos-dir JobId 38: unsupp=3 error=NDMP4_NO_ERR op=NDMP4_DATA_OP_BACKUP
07-Jul 05:01 bareos-dir JobId 38: state=NDMP4_DATA_STATE_HALTED
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_DATA_HALT_SUCCESSFUL
07-Jul 05:01 bareos-dir JobId 38: bytes_processed=2637066240 est_bytes_remain=0
07-Jul 05:01 bareos-dir JobId 38: est_time_remain=0 data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:01 bareos-dir JobId 38: read_offset=0 read_length=0
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_MOVER_GET_STATE 18
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_MOVER_GET_STATE 18 (21)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR state=NDMP4_MOVER_STATE_HALTED
07-Jul 05:01 bareos-dir JobId 38: pause_reason=NDMP4_MOVER_PAUSE_NA
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_MOVER_HALT_CONNECT_CLOSED
07-Jul 05:01 bareos-dir JobId 38: record_size=262144 record_num=10060 bytes_moved=2637168640
07-Jul 05:01 bareos-dir JobId 38: seek=0 to_read=0 win_off=0 win_len=-1
07-Jul 05:01 bareos-dir JobId 38: data_conn_addr=NDMP4_ADDR_TCP0(172.16.10.140:38143)
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_TAPE_GET_STATE 19
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_TAPE_GET_STATE 19 (22)
07-Jul 05:01 bareos-dir JobId 38: unsupp=30 error=NDMP4_NO_ERR flags=0x0 file_num=0
07-Jul 05:01 bareos-dir JobId 38: soft_errors=0 block_size=0 blockno=10060
07-Jul 05:01 bareos-dir JobId 38: total_space=-1 space_remain=-1
07-Jul 05:01 bareos-dir JobId 38: Commanding tape drive to NDMP9_MTIO_EOF 2 times
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_TAPE_MTIO 20
07-Jul 05:01 bareos-dir JobId 38: op=NDMP4_MTIO_EOF count=2
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_TAPE_MTIO 20 (23)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR resid_count=0
07-Jul 05:01 bareos-dir JobId 38: Commanding tape drive to rewind
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_TAPE_MTIO 21
07-Jul 05:01 bareos-dir JobId 38: op=NDMP4_MTIO_REW count=1
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_TAPE_MTIO 21 (24)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR resid_count=0
07-Jul 05:01 bareos-dir JobId 38: Closing tape drive NKGO-AALJ-CHPP-GMOB-POMJ-MCEH-BJDL-OMHK@/vol/vol0%3
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_TAPE_CLOSE 22
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_TAPE_CLOSE 22 (25)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 05:01 bareos-dir JobId 38: Operation halted, stopping
07-Jul 05:01 bareos-dir JobId 38: Operation ended OKAY
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_DATA_STOP 13
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_DATA_STOP 13 (17)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_MOVER_STOP 23
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_MOVER_STOP 23 (26)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_DATA_GET_STATE 14
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_DATA_GET_STATE 14 (18)
07-Jul 05:01 bareos-dir JobId 38: unsupp=3 error=NDMP4_NO_ERR op=NDMP4_DATA_OP_NOACTION
07-Jul 05:01 bareos-dir JobId 38: state=NDMP4_DATA_STATE_IDLE
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_DATA_HALT_NA
07-Jul 05:01 bareos-dir JobId 38: bytes_processed=0 est_bytes_remain=0
07-Jul 05:01 bareos-dir JobId 38: est_time_remain=0 data_conn_addr=NDMP4_ADDR_LOCAL
07-Jul 05:01 bareos-dir JobId 38: read_offset=0 read_length=0
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_MOVER_GET_STATE 24
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_MOVER_GET_STATE 24 (27)
07-Jul 05:01 bareos-dir JobId 38: error=NDMP4_NO_ERR state=NDMP4_MOVER_STATE_IDLE
07-Jul 05:01 bareos-dir JobId 38: pause_reason=NDMP4_MOVER_PAUSE_NA
07-Jul 05:01 bareos-dir JobId 38: halt_reason=NDMP4_MOVER_HALT_NA
07-Jul 05:01 bareos-dir JobId 38: record_size=10240 record_num=0 bytes_moved=0
07-Jul 05:01 bareos-dir JobId 38: seek=0 to_read=0 win_off=0 win_len=-1
07-Jul 05:01 bareos-dir JobId 38: data_conn_addr=NDMP4_ADDR_LOCAL
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_TAPE_GET_STATE 25
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_TAPE_GET_STATE 25 (28)
07-Jul 05:01 bareos-dir JobId 38: unsupp=3f error=NDMP4_DEV_NOT_OPEN_ERR flags=0x0 file_num=4294967295
07-Jul 05:01 bareos-dir JobId 38: soft_errors=4294967295 block_size=4294967295 blockno=4294967295
07-Jul 05:01 bareos-dir JobId 38: total_space=-1 space_remain=-1
07-Jul 05:01 bareos-dir JobId 38: C> NDMP4_CONNECT_CLOSE 26
07-Jul 05:01 bareos-dir JobId 38: >R NDMP4_CONNECT_CLOSE 26 (29)
07-Jul 05:01 bareos-dir JobId 38: Now processing lmdb database
07-Jul 05:01 bareos-dir JobId 38: Processing lmdb database done
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: SMTAPE_BACKUP_SET_ID=395f2509-dee1-11eb-8696-123478563412
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: DUMP_DATE=129-189311
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: BASE_DATE=-1
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: PATHNAME_SEPARATOR=/
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: NDMP_VERSION=4
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: IGNORE_CTIME=Y
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: DATA_BLOCK_SIZE=240
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: SMTAPE_DELETE_SNAPSHOT=N
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: FILESYSTEM=/vol/vol0
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: UPDATE=Y
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: LEVEL=3
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: TYPE=smtape
07-Jul 05:01 bareos-dir JobId 38: NDMP Environment: HIST=N
07-Jul 05:01 bareos-sd JobId 38: Elapsed time=00:01:55, Transfer rate=22.93 M Bytes/second
07-Jul 05:01 bareos-sd JobId 38: Releasing device "FileStorage" (/mnt/Bareos_bk01/backup_vol01).
07-Jul 05:01 bareos-dir JobId 38: Insert of attributes batch table with 1 entries start
07-Jul 05:01 bareos-dir JobId 38: Insert of attributes batch table done
07-Jul 05:01 bareos-dir JobId 38: Bareos bareos-dir 20.0.1 (02Mar21):
Build OS: Ubuntu 20.04.1 LTS
JobId: 38
Job: BackupNDMPSMTape.2021-07-07_04.59.37_12
Backup Level: Incremental, since=2021-07-07 03:20:47
Client: "fas3240a-ndmp"
FileSet: "NDMP SMtape Fileset" 2021-07-04 12:46:06
Pool: "Incremental" (From command line)
Catalog: "MyCatalog" (From Client resource)
Storage: "NDMPFile" (From command line)
Scheduled time: 07-Jul-2021 04:59:37
Start time: 07-Jul-2021 04:59:39
End time: 07-Jul-2021 05:01:35
Elapsed time: 1 min 56 secs
Priority: 10
NDMP Files Written: 1
SD Files Written: 1
NDMP Bytes Written: 2,637,066,240 (2.637 GB)
SD Bytes Written: 2,637,168,731 (2.637 GB)
Rate: 22733.3 KB/s
Volume name(s): Incremental-0005
Volume Session Id: 1
Volume Session Time: 1625633855
Last Volume Bytes: 6,850,070,685 (6.850 GB)
Bareos binary info: bareos.org build: Get official binaries and vendor support on bareos.com
Job triggered by: User
Termination: Backup OK
fas3240a> rdfile /etc/log/backup (null) Mon Jul 5 02:45:38 GMT (null) MGR-Start (smtape manager started) 16 Wed Jul 7 13:07:27 CST /vol/vol0 BKP-Start (level 0 backup of Backup Set ID 395f2509-dee1-11eb-8696-123478563412) 16 Wed Jul 7 13:07:27 CST /vol/vol0 BKP-Params (originator=NDMP mode=dw-data tape_record_size=0KB tape=NDMP_REMOTE_083771 all_snapshots tape_seeding inline 3-way) 16 Wed Jul 7 13:07:27 CST /vol/vol0 BKP-DW-Start 16 Wed Jul 7 13:09:20 CST /vol/vol0 BKP-DW-End (phase completed in 0:01:53; 642220 blocks moved) 16 Wed Jul 7 13:09:20 CST /vol/vol0 BKP-Tape-Stats (wait_time=0s wait_count=0 total_count=0 avail_count=0/0/0/0) 16 Wed Jul 7 13:09:20 CST /vol/vol0 BKP-End (backed up 2.568 GB bytes in 0:01:53; performance=81.840 GB/hour)
Although the backup level set to 3 on bareos side, netapp filer recognize it as level 0 backup.
Reply all
Reply to author
Forward
0 new messages