Jan 6 07:25:10 tidb1 ansible-command: Invoked with warn=True executable=None _uses_shell=True _raw_params=pkill -f "ssh.*ansible.*" removes=None argv=None creates=None chdir=None stdin=None
Jan 6 07:25:11 tidb1 systemd-logind: Removed session 87.
Jan 6 07:25:11 tidb1 systemd: Removed slice User Slice of tidb.
Jan 6 07:25:11 tidb1 ansible-command: Invoked with warn=True executable=None _uses_shell=True _raw_params=pip list | grep -iw jmespath | wc -l removes=None argv=None creates=None chdir=None stdin=None
Jan 6 07:25:11 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:25:11 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:25:11 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:25:11 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:25:11 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:25:11 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:25:12 tidb1 ansible-command: Invoked with warn=True executable=None _uses_shell=True _raw_params=pip list | grep -iw jinja2 | wc -l removes=None argv=None creates=None chdir=None stdin=None
Jan 6 07:25:13 tidb1 ansible-command: Invoked with warn=True executable=None _uses_shell=True _raw_params=pip show jmespath | grep Version |grep -v Metadata-Version removes=None argv=None creates=None chdir=None stdin=None
Jan 6 07:25:14 tidb1 ansible-command: Invoked with warn=True executable=None _uses_shell=True _raw_params=pip show jinja2 | grep Version |grep -v Metadata-Version removes=None argv=None creates=None chdir=None stdin=None
Jan 6 07:25:14 tidb1 ansible-command: Invoked with warn=True executable=None _uses_shell=True _raw_params=python2 /home/tidb/tidb-ansible/scripts/inventory_check.py /home/tidb/tidb-ansible/inventory.ini removes=None argv=None creates=None chdir=None stdin=None
Jan 6 07:25:16 tidb1 systemd: Created slice User Slice of tidb.
Jan 6 07:25:16 tidb1 systemd-logind: New session 88 of user tidb.
Jan 6 07:25:16 tidb1 systemd: Started Session 88 of user tidb.
Jan 6 07:25:17 tidb1 ansible-stat: Invoked with checksum_algorithm=sha1 get_checksum=False follow=False path=/home/tidb/deploy get_md5=False get_mime=True get_attributes=True
Jan 6 07:25:19 tidb1 ansible-wait_for: Invoked with active_connection_states=['ESTABLISHED', 'FIN_WAIT1', 'FIN_WAIT2', 'SYN_RECV', 'SYN_SENT', 'TIME_WAIT'] host=10.0.0.3 port=4000 delay=0 msg=4000 already in use state=stopped sleep=1 timeout=3 exclude_hosts=None search_regex=None path=None connect_timeout=5
Jan 6 07:25:20 tidb1 ansible-wait_for: Invoked with active_connection_states=['ESTABLISHED', 'FIN_WAIT1', 'FIN_WAIT2', 'SYN_RECV', 'SYN_SENT', 'TIME_WAIT'] host=10.0.0.3 port=10080 delay=0 msg=10080 already in use state=stopped sleep=1 timeout=3 exclude_hosts=None search_regex=None path=None connect_timeout=5
Jan 6 07:25:21 tidb1 ansible-systemd: Invoked with no_block=False force=None name=tidb-4000.service enabled=False daemon_reload=False state=started masked=None scope=None user=None
Jan 6 07:25:22 tidb1 ansible-wait_for: Invoked with active_connection_states=['ESTABLISHED', 'FIN_WAIT1', 'FIN_WAIT2', 'SYN_RECV', 'SYN_SENT', 'TIME_WAIT'] host=10.0.0.3 port=4000 delay=0 msg=the TiDB port 4000 is not up state=started sleep=1 timeout=300 exclude_hosts=None search_regex=None path=None connect_timeout=5
Jan 6 07:25:26 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:25:26 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:25:26 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:25:26 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:25:26 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:25:26 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:25:42 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:25:42 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:25:42 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:25:42 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:25:42 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:25:42 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:25:57 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:25:57 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:25:57 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:25:57 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:25:57 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:25:57 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:26:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:26:01.838830122Z caller=notify.go:339 component=dispatcher msg="Error on notify" err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:26:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:26:01.838894609Z caller=dispatch.go:264 component=dispatcher msg="Notify for alerts failed" num_alerts=1 err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:26:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:26:01.8388299Z caller=notify.go:339 component=dispatcher msg="Error on notify" err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:26:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:26:01.838952053Z caller=dispatch.go:264 component=dispatcher msg="Notify for alerts failed" num_alerts=1 err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:26:12 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:26:12 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:26:12 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:26:12 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:26:12 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:26:12 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:26:27 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:26:27 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:26:27 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:26:27 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:26:27 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:26:27 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:26:43 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:26:43 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:26:43 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:26:43 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:26:43 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:26:43 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:26:44 tidb1 dhclient[1565]: DHCPREQUEST on eth0 to 169.254.169.254 port 67 (xid=0x6acd3eae)
Jan 6 07:26:44 tidb1 dhclient[1565]: DHCPACK from 169.254.169.254 (xid=0x6acd3eae)
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0974] dhcp4 (eth0): address 10.0.0.3
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0978] dhcp4 (eth0): plen 32 (255.255.255.255)
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0978] dhcp4 (eth0): classless static route 10.0.0.1/32 gw 0.0.0.0
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0978] dhcp4 (eth0): gateway 10.0.0.1
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp4 (eth0): lease time 3600
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp4 (eth0): hostname 'tidb1'
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp4 (eth0): nameserver '1.1.1.1'
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp4 (eth0): domain name 'xxx'
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp (eth0): domain search 'xxx'
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp (eth0): domain search 'xxx'
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp (eth0): domain search 'xxx'
Jan 6 07:26:44 tidb1 NetworkManager[1502]: <info> [1578295604.0979] dhcp4 (eth0): state changed bound -> bound
Jan 6 07:26:44 tidb1 dbus[1476]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Jan 6 07:26:44 tidb1 systemd: Starting Network Manager Script Dispatcher Service...
Jan 6 07:26:44 tidb1 dhclient[1565]: bound to 10.0.0.3 -- renewal in 1647 seconds.
Jan 6 07:26:44 tidb1 dbus[1476]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jan 6 07:26:44 tidb1 systemd: Started Network Manager Script Dispatcher Service.
Jan 6 07:26:44 tidb1 nm-dispatcher: req:1 'dhcp4-change' [eth0]: new request (3 scripts)
Jan 6 07:26:44 tidb1 nm-dispatcher: req:1 'dhcp4-change' [eth0]: start running ordered scripts...
Jan 6 07:26:46 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:26:46.812842467Z caller=notify.go:339 component=dispatcher msg="Error on notify" err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:26:46 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:26:46.812907414Z caller=dispatch.go:264 component=dispatcher msg="Notify for alerts failed" num_alerts=1 err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:26:58 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:26:58 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:26:58 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:26:58 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:26:58 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:26:58 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:27:13 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:27:13 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:27:13 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:27:13 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:27:13 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:27:13 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:27:28 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:27:28 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:27:28 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:27:28 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:27:28 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:27:28 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:27:43 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:27:43 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:27:43 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:27:43 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:27:43 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:27:43 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:27:58 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:27:58 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:27:58 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:27:58 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:27:58 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:27:58 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:28:13 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:28:13 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:28:13 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:28:13 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:28:13 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:28:13 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:28:28 tidb1 systemd: tidb-4000.service holdoff time over, scheduling restart.
Jan 6 07:28:28 tidb1 systemd: Stopped tidb-4000 service.
Jan 6 07:28:28 tidb1 systemd: Started tidb-4000 service.
Jan 6 07:28:28 tidb1 systemd: tidb-4000.service: main process exited, code=exited, status=1/FAILURE
Jan 6 07:28:28 tidb1 systemd: Unit tidb-4000.service entered failed state.
Jan 6 07:28:28 tidb1 systemd: tidb-4000.service failed.
Jan 6 07:29:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:29:01.83911535Z caller=notify.go:339 component=dispatcher msg="Error on notify" err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:29:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:29:01.839164011Z caller=notify.go:339 component=dispatcher msg="Error on notify" err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:29:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:29:01.839200259Z caller=dispatch.go:264 component=dispatcher msg="Notify for alerts failed" num_alerts=1 err="require_tls: true (default), but \"localhost:25\" does not advertise the STARTTLS extension"
Jan 6 07:29:01 tidb1 run_alertmanager.sh: level=error ts=2020-01-06T07:29:01.839231136Z caller=dispatch.go:264 component=dispatcher msg="Notify for alerts failed" num_alerts=1 err="requi