Skip to content

Instantly share code, notes, and snippets.

@rreilly-edr

rreilly-edr/gist:37ea6314b19ecc96f31c3d846df0219d Secret

Created September 6, 2019 13:32
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save rreilly-edr/37ea6314b19ecc96f31c3d846df0219d to your computer and use it in GitHub Desktop.
Save rreilly-edr/37ea6314b19ecc96f31c3d846df0219d to your computer and use it in GitHub Desktop.
Download ZIP
Raw
gistfile1.txt
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: pid 7222 ruid 34 euid 34 version 3.3.6: start at Thu Sep 5 02:00:02 2019
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: security_getdriver(name=ssh) returns 0x7eff84232f80
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: version 3.3.6
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: build: VERSION="Amanda-3.3.6"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: BUILT_DATE="Tue Dec 29 05:11:51 UTC 2015" BUILT_MACH=""
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: BUILT_REV="5813" BUILT_BRANCH="tags" CC="gcc"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: paths: bindir="/usr/sbin" sbindir="/usr/sbin"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: libexecdir="/usr/lib/amanda"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: amlibexecdir="/usr/lib/amanda" mandir="/usr/share/man"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: AMANDA_TMPDIR="/tmp/amanda"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: AMANDA_DBGDIR="/var/log/amanda" CONFIG_DIR="/etc/amanda"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: DEV_PREFIX="/dev/" RDEV_PREFIX="/dev/r"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: DUMP="/sbin/dump" RESTORE="/sbin/restore" VDUMP=UNDEF
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: VRESTORE=UNDEF XFSDUMP="/sbin/xfsdump"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: XFSRESTORE="/sbin/xfsrestore" VXDUMP=UNDEF VXRESTORE=UNDEF
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: SAMBA_CLIENT="/usr/bin/smbclient" GNUTAR="/bin/tar"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: COMPRESS_PATH="/bin/gzip" UNCOMPRESS_PATH="/bin/gzip"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: LPRCMD=UNDEF MAILER=UNDEF
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: listed_incr_dir="/var/lib/amanda/gnutar-lists"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: defs: DEFAULT_SERVER="localhost" DEFAULT_CONFIG="DailySet1"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: DEFAULT_TAPE_SERVER="localhost" DEFAULT_TAPE_DEVICE=""
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: NEED_STRSTR AMFLOCK_POSIX AMFLOCK_FLOCK AMFLOCK_LOCKF
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: AMFLOCK_LNLOCK SETPGRP_VOID AMANDA_DEBUG_DAYS=4 BSD_SECURITY
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: USE_AMANDAHOSTS CLIENT_LOGIN="backup" CHECK_USERID HAVE_GZIP
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: COMPRESS_SUFFIX=".gz" COMPRESS_FAST_OPT="--fast"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: COMPRESS_BEST_OPT="--best" UNCOMPRESS_OPT="-dc"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: CONFIGURE_ARGS=" '--prefix=/usr' '--bindir=/usr/sbin' '--libexecdir=/usr/lib/amanda' '--without-amlibexecdir' '--without-amperldir' '--sysconfdir=/etc' '--sharedstatedir=/var/lib' '--localstatedir=/var/lib' '--with-user=backup' '--with-group=backup' '--with-tcpportrange=50000,50100' '--with-udpportrange=840,860' '--with-debugging=/var/log/amanda' '--with-gnutar-listdir=/var/lib/amanda/gnutar-lists' '--with-index-server=localhost' '--with-bsd-security' '--with-smbclient=/usr/bin/smbclient' '--with-amandahosts' '--with-ssh-security' '--with-bsdtcp-security' '--with-bsdudp-security' '--without-ipv6' '--enable-s3-device' 'CFLAGS=-g -O2 -fPIE -fstack-protector-strong -Wformat -Werror=format-security' 'LDFLAGS=-Wl,-Bsymbolic-functions -fPIE -pie -Wl,-z,relro -Wl,-z,now' 'CPPFLAGS=-D_FORTIFY_SOURCE=2'"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec_tcp_conn_get:
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec_tcp_conn_get: creating new handle
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: parsing 172.31.28.117
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: conn_read registering event handler for 172.31.28.117
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: tcpm_recv_token: read 72 bytes from 2
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 72
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 0
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: security_handleinit(handle=0x55f34089dbf0, driver=0x7eff84232f80 (SSH))
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: security_streaminit(stream=0x55f34089dd30, driver=0x7eff84232f80 (SSH))
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: stream_client: connected to stream 2
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: new connection
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: parse_pkt: parsing buffer of 72 bytes
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: parse_pkt: REQ (0): "SERVICE noop
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;
"
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: calling accept_fn
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: authenticated peer name is '172.31.28.117'
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: accept recv REQ pkt:
<<<<<
SERVICE noop
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;
>>>>>
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: creating new service: noop
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sending ACK pkt:
<<<<<
>>>>>
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: enter
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: ACK (3) pkt_t (len 0) contains:
""
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 2 bytes to 172.31.28.117:2 1
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: tcpm_send_token: data is still flowing
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 2 bytes to handle 2
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: recvpkt registered for 172.31.28.117
Thu Sep 5 02:00:02 2019: thd-0x55f340893400: amandad: sec: conn_read: incremented ev_read_refcnt to 2 for 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sending REP pkt:
<<<<<
OPTIONS features=ffffffff9efefbffffffffff3f;
>>>>>
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: enter
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: REP (1) pkt_t (len 45) contains:
"OPTIONS features=ffffffff9efefbffffffffff3f;
"
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 47 bytes to 172.31.28.117:2 1
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 47 bytes to handle 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: recvpkt registered for 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: tcpm_recv_token: read 2 bytes from 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: handle 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: it was for us
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: read 2 bytes from 172.31.28.117:2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: recvpkt_callback: 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: cancelling recvpkt for 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_cancel: decremented ev_read_refcnt to 1 for 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: parse_pkt: parsing buffer of 2 bytes
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: parse_pkt: ACK (3): ""
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: received ACK packet (3) from 172.31.28.117, contains:
""
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: received ACK pkt:
<<<<<
>>>>>
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: security_close(handle=0x55f34089dbf0, driver=0x7eff84232f80 (SSH))
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: closing handle to 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: cancelling recvpkt for 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: security_stream_close(0x55f34089dd30)
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: tcpma_stream_close: closing stream 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 0 bytes to 172.31.28.117:2 1
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 0 bytes to handle 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec_tcp_conn_put: decrementing refcnt for 172.31.28.117 to 1
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: Waitpid for process 7223 failed: No child processes
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: after callback stream_read_callback
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 1
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: tcpm_recv_token: read EOF from 2
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 0
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 0
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: tcpm_recv_token: read 374 bytes from 3
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 374
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 0
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: security_handleinit(handle=0x55f34089e3d0, driver=0x7eff84232f80 (SSH))
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: security_streaminit(stream=0x55f3408ae520, driver=0x7eff84232f80 (SSH))
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_client: connected to stream 3
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: new connection
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: parse_pkt: parsing buffer of 374 bytes
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: parse_pkt: REQ (0): "SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
"
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: calling accept_fn
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: authenticated peer name is '172.31.28.117'
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: accept recv REQ pkt:
<<<<<
SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
>>>>>
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: creating new service: sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sending ACK pkt:
<<<<<
>>>>>
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: enter
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: ACK (3) pkt_t (len 0) contains:
""
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 2 bytes to 172.31.28.117:3 1
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 2 bytes to handle 3
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: recvpkt registered for 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: conn_read: incremented ev_read_refcnt to 2 for 172.31.28.117
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sending PREP pkt:
<<<<<
OPTIONS features=ffffffff9efefbffffffffff3f;
>>>>>
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: enter
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: PREP (2) pkt_t (len 45) contains:
"OPTIONS features=ffffffff9efefbffffffffff3f;
"
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 47 bytes to 172.31.28.117:3 1
Thu Sep 5 02:00:03 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 47 bytes to handle 3
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: tcpm_recv_token: read 374 bytes from 3
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 374
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: stream_read_callback: data is still flowing
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: handle 3
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: it was for us
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: read 374 bytes from 172.31.28.117:3
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: recvpkt_callback: 374
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: cancelling recvpkt for 172.31.28.117
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: conn_read_cancel: decremented ev_read_refcnt to 1 for 172.31.28.117
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: parse_pkt: parsing buffer of 374 bytes
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: parse_pkt: REQ (0): "SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
"
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: received REQ packet (0) from 172.31.28.117, contains:
"SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
"
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: received REQ pkt:
<<<<<
SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
>>>>>
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: received dup P_REQ packet, ACKing it
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sending ACK pkt:
<<<<<
>>>>>
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: enter
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: ACK (3) pkt_t (len 0) contains:
""
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 2 bytes to 172.31.28.117:3 1
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 2 bytes to handle 3
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: recvpkt registered for 172.31.28.117
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: conn_read: incremented ev_read_refcnt to 2 for 172.31.28.117
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: after callback stream_read_callback
Thu Sep 5 02:05:04 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 1
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: tcpm_recv_token: read 374 bytes from 3
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 374
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: stream_read_callback: data is still flowing
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: handle 3
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: it was for us
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: read 374 bytes from 172.31.28.117:3
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: recvpkt_callback: 374
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: cancelling recvpkt for 172.31.28.117
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: conn_read_cancel: decremented ev_read_refcnt to 1 for 172.31.28.117
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: parse_pkt: parsing buffer of 374 bytes
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: parse_pkt: REQ (0): "SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
"
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: received REQ packet (0) from 172.31.28.117, contains:
"SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
"
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: received REQ pkt:
<<<<<
SERVICE sendsize
OPTIONS features=ffffffff9efefbfffffffffffffff3fffbf71f;maxdumps=2;hostname=tf-p-ubu-sensugo-00.xx;config=DailySet1;
<dle>
<program>GNUTAR</program>
<estimate>CALCSIZE </estimate>
<disk>/</disk>
<level>0</level>
<spindle>-1</spindle>
<auth>ssh</auth>
<record>YES</record>
<index>YES</index>
<datapath>AMANDA</datapath>
</dle>
>>>>>
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: received dup P_REQ packet, ACKing it
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sending ACK pkt:
<<<<<
>>>>>
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: enter
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: ACK (3) pkt_t (len 0) contains:
""
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 2 bytes to 172.31.28.117:3 1
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 2 bytes to handle 3
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: recvpkt registered for 172.31.28.117
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: conn_read: incremented ev_read_refcnt to 2 for 172.31.28.117
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: after callback stream_read_callback
Thu Sep 5 02:10:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 1
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: tcpm_recv_token: read EOF from 3
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 0
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: stream_read_callback: data is still flowing
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: handle 3
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: it was for us
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: stream_read_callback: EOF
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: conn_read_cancel: decremented ev_read_refcnt to 1 for 172.31.28.117
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: security_stream_seterr(0x55f3408ae520, EOF)
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec_tcp_conn_put: decrementing refcnt for 172.31.28.117 to 1
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: recvpkt_callback: 0
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: cancelling recvpkt for 172.31.28.117
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: security_seterror(handle=0x55f34089e3d0, driver=0x7eff84232f80 (SSH) error=EOF on read from 172.31.28.117)
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: receive error: EOF on read from 172.31.28.117
Thu Sep 5 02:15:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 1
Thu Sep 5 02:30:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback 1 0
Thu Sep 5 02:30:05 2019: thd-0x55f340893400: amandad: tcpm_recv_token: A return(0)
Thu Sep 5 02:30:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: tcpm_recv_token returned 0
Thu Sep 5 02:30:05 2019: thd-0x55f340893400: amandad: sec: conn_read_callback: event_wakeup return 0
Thu Sep 5 02:30:05 2019: thd-0x55f340893400: amandad: sec_tcp_conn_put: decrementing refcnt for 172.31.28.117 to 0
Thu Sep 5 02:30:05 2019: thd-0x55f340893400: amandad: sec_tcp_conn_put: closing connection to 172.31.28.117
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: /usr/lib/amanda/sendsize timed out waiting for REP data
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: sending NAK pkt:
<<<<<
ERROR timeout on reply pipe
>>>>>
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: enter
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: sec: stream_sendpkt: NAK (4) pkt_t (len 28) contains:
"ERROR timeout on reply pipe
"
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: sec: stream_write: writing 30 bytes to 172.31.28.117:3 -1
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: tcpm_send_token: data is still flowing
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: tcpm_send_token: write 30 bytes to handle 3
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: security_stream_seterr(0x55f3408ae520, write error to: Bad file descriptor)
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: security_seterror(handle=0x55f34089e3d0, driver=0x7eff84232f80 (SSH) error=write error to: Bad file descriptor)
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: security_close(handle=0x55f34089e3d0, driver=0x7eff84232f80 (SSH))
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: sec: closing handle to 172.31.28.117
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: sec: cancelling recvpkt for 172.31.28.117
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: security_stream_close(0x55f3408ae520)
Thu Sep 5 08:00:03 2019: thd-0x55f340893400: amandad: sec: tcpma_stream_close: closing stream 3
Thu Sep 5 08:00:04 2019: thd-0x55f340893400: amandad: pid 7222 finish time Thu Sep 5 08:00:04 2019
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment