2019-09-02 02:04:50,579 [salt.utils       :831 ][ERROR   ][1655] DNS lookup or connection check of 'salt' failed.
2019-09-02 02:04:50,579 [salt.minion      :152 ][ERROR   ][1655] Master hostname: 'salt' not found or not responsive. Retrying in 30 seconds
2019-09-02 02:04:52,849 [salt.utils.parsers:1051][WARNING ][1655] Minion received a SIGTERM. Exiting.
2019-09-02 02:05:34,874 [salt.minion      :870 ][ERROR   ][1868] Error while bringing up minion for multi-master. Is master at 192.168.11.2 responding?
2019-09-02 02:06:36,922 [salt.utils.decorators:613 ][WARNING ][2097] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:06:53,718 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /boot/grub/grub.cfg - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:03,892 [salt.utils.decorators:613 ][WARNING ][2097] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:07:04,027 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/shadow - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:04,029 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/gshadow - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:04,030 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/group- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:04,031 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/group - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:04,032 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/passwd- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:04,033 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/passwd - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:04,034 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/gshadow- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:04,036 [salt.loaded.int.states.file:2298][WARNING ][2097] State for file: /etc/shadow- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:07:08,530 [salt.loaded.int.module.debian_ip:1964][WARNING ][2097] The network state sls is requiring a reboot of the system to properly apply network configuration.
2019-09-02 02:07:08,741 [salt.loaded.int.module.cmdmod:730 ][ERROR   ][2097] Command '['umount', '/dev/shm']' failed with return code: 32
2019-09-02 02:07:08,741 [salt.loaded.int.module.cmdmod:734 ][ERROR   ][2097] stderr: umount: /dev/shm: target is busy
        (In some cases useful info about processes that
         use the device is found by lsof(8) or fuser(1).)
2019-09-02 02:07:08,741 [salt.loaded.int.module.cmdmod:736 ][ERROR   ][2097] retcode: 32
2019-09-02 02:09:01,340 [salt.utils.parsers:1051][WARNING ][1868] Minion received a SIGTERM. Exiting.
2019-09-02 02:10:49,571 [salt.utils.decorators:613 ][WARNING ][3543] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-02 02:11:00,121 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5086] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-09-02 02:11:00,144 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5086] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-09-02 02:11:00,159 [salt.utils.parsers:1051][WARNING ][1990] Minion received a SIGTERM. Exiting.
2019-09-02 02:11:01,173 [salt.cli.daemons :293 ][INFO    ][5141] Setting up the Salt Minion "odl01.mcp-odl-noha.local"
2019-09-02 02:11:01,371 [salt.cli.daemons :82  ][INFO    ][5141] Starting up the Salt Minion
2019-09-02 02:11:01,371 [salt.utils.event :1017][INFO    ][5141] Starting pull socket on /var/run/salt/minion/minion_event_0d1d1cf3c0_pull.ipc
2019-09-02 02:11:02,033 [salt.minion      :976 ][INFO    ][5141] Creating minion process manager
2019-09-02 02:11:03,229 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][5141] Executing command ['date', '+%z'] in directory '/root'
2019-09-02 02:11:03,249 [salt.utils.schedule:568 ][INFO    ][5141] Updating job settings for scheduled job: __mine_interval
2019-09-02 02:11:03,251 [salt.minion      :1108][INFO    ][5141] Added mine.update to scheduler
2019-09-02 02:11:03,256 [salt.minion      :1975][INFO    ][5141] Minion is starting as user 'root'
2019-09-02 02:11:03,267 [salt.minion      :2336][INFO    ][5141] Minion is ready to receive requests!
2019-09-02 02:11:34,374 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command state.sls with jid 20190902021134366985
2019-09-02 02:11:34,388 [salt.minion      :1432][INFO    ][5231] Starting a new job with PID 5231
2019-09-02 02:11:39,717 [salt.state       :915 ][INFO    ][5231] Loading fresh modules for state activity
2019-09-02 02:11:39,769 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
2019-09-02 02:11:39,794 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
2019-09-02 02:11:39,818 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2019-09-02 02:11:39,848 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/config.sls'
2019-09-02 02:11:39,907 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/repo.sls'
2019-09-02 02:11:40,588 [salt.state       :1780][INFO    ][5231] Running state [cat <<-EOF | sudo apt-key add -
-----BEGIN PGP PUBLIC KEY BLOCK-----
Version: GnuPG v1

mQINBFiKaBEBEADpCtIj8utf/bUfN6iQ+sxGiOPLnXVYoYyKifHDazD4o1Jevfiu
EpcDIx9EdnhrCpvKTU+jaw2B7K3pkdqbjbzjZY+2CDENSQXfRHuuI/nWDaYI0stx
Tf/evip3cxdutnZNAklzkxppHP+4UZm9HAd7uZsEyff4H9DIsHzZIA4Z++Hx2+lt
w9K0iCKh2k6Pon/VVo8Bir3JuKIIdLRAuHmyniYlHDswQnu+1nQHE0F/oboD0Q9Z
hOvXAr1L7LWu0hkLV7BqmeI0SPcRA3b5MU3dfaTK8MaPAo8anQTpCyYUnoIBqX8h
y324T/dvpFKq2/X3RL+wOSYTA8TLgyhH0fhdIKZg3G8m9kxuAHZYHIHnDtvgJ5yd
72tNY+w8UIX8U2ark/WdkAMZr3O0AuTDlvHcasxO5+puAu8jh0EgtqItqrvKwiF7
dmlHVW41Rt+su2fmsUkk4Z0IhWrn3PdrSWAcH2eL6vjuqx6CccpjsjyiSQ90dUox
EoMpY+viX59aF0kU4BLt76mQO6YZtCpicLxFGCu97v1mNn+FWjhBOIF08pVsbNlq
oMl2j0N8NKZxJvkkmsA/i//ch5FsjzvUy3xajlSzq9ruWS4SlWq2Vzdx/acvF7Oa
ABA11wIjzLc9vmhzQNiRa53fJQwi+w/Or9LtH2msKCbcPVHoZ5OT4t6S8QARAQAB
tBpMYXVuY2hwYWQgUFBBIGZvciBPREwgVGVhbYkCOAQTAQIAIgUCWIpoEQIbAwYL
CQgHAwIGFQgCCQoLBBYCAwECHgECF4AACgkQe4qho0TAUkgAmg//XY/RqU4WcT+p
13oDc3+Dp4aL+rwaNz0o56i0z0cYPxd8GPicCuS8d/di07GnQiBcZ5DZgegnnaYm
OUF+phxk4q+jYO/t2GHQlYSf/QyUv7OimidLOHN1FiahmcGobliwih70o6ZcMT84
ggSu8jBzA/HLFBIkgStKD/staR5zJ2HfK298yVhiffyrPA+I3nPe7pvTaGa2e8AP
BYs5zB5n27upSZIokXFvqlmS4HEKDmPcY061wgmg1cNY1Y+mIuGjxY1Igbi6kAe0
yaLN2AN4c2ImhpwOcuazKTe/q2ZhoPTpYvuzmogwau8LBjRBhVS6fkTpSBPEkcwn
f/QYmmVLygmpMDHuHapyH8iaUoksq7gd64iBRDJQN7giQSjkTVvcGBqoKG8lbUMV
MDT4FGuYYsObWUg7kmHlNq9nIVlAxmxv8ZTg9+8xy3f53aId/51m+gW9LGRAT94T
ZIWrF9cBvsPWoHgHkV1At/fPprOvNXqeQiJ7UzC3ikDNCu2AjPEbA4sb019RNgtj
jUI6g6RZdzbeKVpptxILCtT3yKbfKj8AfrfaRzS0yMhVudgLolIUA4S6g46p0Cgy
gITO49wxxBu6UAOsAG3psDRlsZmmrT4AH09Yt2RzmY0FBWValqpoPagheQqeU+2W
FKnV9Lw1SKMtWZbYMvIlB0rwts3k9lE=
=xkZ9
-----END PGP PUBLIC KEY BLOCK-----
EOF] at time 02:11:40.588030
2019-09-02 02:11:40,589 [salt.state       :1813][INFO    ][5231] Executing state cmd.run for [cat <<-EOF | sudo apt-key add -
-----BEGIN PGP PUBLIC KEY BLOCK-----
Version: GnuPG v1

mQINBFiKaBEBEADpCtIj8utf/bUfN6iQ+sxGiOPLnXVYoYyKifHDazD4o1Jevfiu
EpcDIx9EdnhrCpvKTU+jaw2B7K3pkdqbjbzjZY+2CDENSQXfRHuuI/nWDaYI0stx
Tf/evip3cxdutnZNAklzkxppHP+4UZm9HAd7uZsEyff4H9DIsHzZIA4Z++Hx2+lt
w9K0iCKh2k6Pon/VVo8Bir3JuKIIdLRAuHmyniYlHDswQnu+1nQHE0F/oboD0Q9Z
hOvXAr1L7LWu0hkLV7BqmeI0SPcRA3b5MU3dfaTK8MaPAo8anQTpCyYUnoIBqX8h
y324T/dvpFKq2/X3RL+wOSYTA8TLgyhH0fhdIKZg3G8m9kxuAHZYHIHnDtvgJ5yd
72tNY+w8UIX8U2ark/WdkAMZr3O0AuTDlvHcasxO5+puAu8jh0EgtqItqrvKwiF7
dmlHVW41Rt+su2fmsUkk4Z0IhWrn3PdrSWAcH2eL6vjuqx6CccpjsjyiSQ90dUox
EoMpY+viX59aF0kU4BLt76mQO6YZtCpicLxFGCu97v1mNn+FWjhBOIF08pVsbNlq
oMl2j0N8NKZxJvkkmsA/i//ch5FsjzvUy3xajlSzq9ruWS4SlWq2Vzdx/acvF7Oa
ABA11wIjzLc9vmhzQNiRa53fJQwi+w/Or9LtH2msKCbcPVHoZ5OT4t6S8QARAQAB
tBpMYXVuY2hwYWQgUFBBIGZvciBPREwgVGVhbYkCOAQTAQIAIgUCWIpoEQIbAwYL
CQgHAwIGFQgCCQoLBBYCAwECHgECF4AACgkQe4qho0TAUkgAmg//XY/RqU4WcT+p
13oDc3+Dp4aL+rwaNz0o56i0z0cYPxd8GPicCuS8d/di07GnQiBcZ5DZgegnnaYm
OUF+phxk4q+jYO/t2GHQlYSf/QyUv7OimidLOHN1FiahmcGobliwih70o6ZcMT84
ggSu8jBzA/HLFBIkgStKD/staR5zJ2HfK298yVhiffyrPA+I3nPe7pvTaGa2e8AP
BYs5zB5n27upSZIokXFvqlmS4HEKDmPcY061wgmg1cNY1Y+mIuGjxY1Igbi6kAe0
yaLN2AN4c2ImhpwOcuazKTe/q2ZhoPTpYvuzmogwau8LBjRBhVS6fkTpSBPEkcwn
f/QYmmVLygmpMDHuHapyH8iaUoksq7gd64iBRDJQN7giQSjkTVvcGBqoKG8lbUMV
MDT4FGuYYsObWUg7kmHlNq9nIVlAxmxv8ZTg9+8xy3f53aId/51m+gW9LGRAT94T
ZIWrF9cBvsPWoHgHkV1At/fPprOvNXqeQiJ7UzC3ikDNCu2AjPEbA4sb019RNgtj
jUI6g6RZdzbeKVpptxILCtT3yKbfKj8AfrfaRzS0yMhVudgLolIUA4S6g46p0Cgy
gITO49wxxBu6UAOsAG3psDRlsZmmrT4AH09Yt2RzmY0FBWValqpoPagheQqeU+2W
FKnV9Lw1SKMtWZbYMvIlB0rwts3k9lE=
=xkZ9
-----END PGP PUBLIC KEY BLOCK-----
EOF]
2019-09-02 02:11:40,589 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command 'apt-key list | grep -qF '4096R/44C05248 2017-01-26'' in directory '/root'
2019-09-02 02:11:40,687 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command 'cat <<-EOF | sudo apt-key add -
-----BEGIN PGP PUBLIC KEY BLOCK-----
Version: GnuPG v1

mQINBFiKaBEBEADpCtIj8utf/bUfN6iQ+sxGiOPLnXVYoYyKifHDazD4o1Jevfiu
EpcDIx9EdnhrCpvKTU+jaw2B7K3pkdqbjbzjZY+2CDENSQXfRHuuI/nWDaYI0stx
Tf/evip3cxdutnZNAklzkxppHP+4UZm9HAd7uZsEyff4H9DIsHzZIA4Z++Hx2+lt
w9K0iCKh2k6Pon/VVo8Bir3JuKIIdLRAuHmyniYlHDswQnu+1nQHE0F/oboD0Q9Z
hOvXAr1L7LWu0hkLV7BqmeI0SPcRA3b5MU3dfaTK8MaPAo8anQTpCyYUnoIBqX8h
y324T/dvpFKq2/X3RL+wOSYTA8TLgyhH0fhdIKZg3G8m9kxuAHZYHIHnDtvgJ5yd
72tNY+w8UIX8U2ark/WdkAMZr3O0AuTDlvHcasxO5+puAu8jh0EgtqItqrvKwiF7
dmlHVW41Rt+su2fmsUkk4Z0IhWrn3PdrSWAcH2eL6vjuqx6CccpjsjyiSQ90dUox
EoMpY+viX59aF0kU4BLt76mQO6YZtCpicLxFGCu97v1mNn+FWjhBOIF08pVsbNlq
oMl2j0N8NKZxJvkkmsA/i//ch5FsjzvUy3xajlSzq9ruWS4SlWq2Vzdx/acvF7Oa
ABA11wIjzLc9vmhzQNiRa53fJQwi+w/Or9LtH2msKCbcPVHoZ5OT4t6S8QARAQAB
tBpMYXVuY2hwYWQgUFBBIGZvciBPREwgVGVhbYkCOAQTAQIAIgUCWIpoEQIbAwYL
CQgHAwIGFQgCCQoLBBYCAwECHgECF4AACgkQe4qho0TAUkgAmg//XY/RqU4WcT+p
13oDc3+Dp4aL+rwaNz0o56i0z0cYPxd8GPicCuS8d/di07GnQiBcZ5DZgegnnaYm
OUF+phxk4q+jYO/t2GHQlYSf/QyUv7OimidLOHN1FiahmcGobliwih70o6ZcMT84
ggSu8jBzA/HLFBIkgStKD/staR5zJ2HfK298yVhiffyrPA+I3nPe7pvTaGa2e8AP
BYs5zB5n27upSZIokXFvqlmS4HEKDmPcY061wgmg1cNY1Y+mIuGjxY1Igbi6kAe0
yaLN2AN4c2ImhpwOcuazKTe/q2ZhoPTpYvuzmogwau8LBjRBhVS6fkTpSBPEkcwn
f/QYmmVLygmpMDHuHapyH8iaUoksq7gd64iBRDJQN7giQSjkTVvcGBqoKG8lbUMV
MDT4FGuYYsObWUg7kmHlNq9nIVlAxmxv8ZTg9+8xy3f53aId/51m+gW9LGRAT94T
ZIWrF9cBvsPWoHgHkV1At/fPprOvNXqeQiJ7UzC3ikDNCu2AjPEbA4sb019RNgtj
jUI6g6RZdzbeKVpptxILCtT3yKbfKj8AfrfaRzS0yMhVudgLolIUA4S6g46p0Cgy
gITO49wxxBu6UAOsAG3psDRlsZmmrT4AH09Yt2RzmY0FBWValqpoPagheQqeU+2W
FKnV9Lw1SKMtWZbYMvIlB0rwts3k9lE=
=xkZ9
-----END PGP PUBLIC KEY BLOCK-----
EOF' in directory '/root'
2019-09-02 02:11:40,867 [salt.state       :300 ][INFO    ][5231] {'pid': 5293, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2019-09-02 02:11:40,867 [salt.state       :1951][INFO    ][5231] Completed state [cat <<-EOF | sudo apt-key add -
-----BEGIN PGP PUBLIC KEY BLOCK-----
Version: GnuPG v1

mQINBFiKaBEBEADpCtIj8utf/bUfN6iQ+sxGiOPLnXVYoYyKifHDazD4o1Jevfiu
EpcDIx9EdnhrCpvKTU+jaw2B7K3pkdqbjbzjZY+2CDENSQXfRHuuI/nWDaYI0stx
Tf/evip3cxdutnZNAklzkxppHP+4UZm9HAd7uZsEyff4H9DIsHzZIA4Z++Hx2+lt
w9K0iCKh2k6Pon/VVo8Bir3JuKIIdLRAuHmyniYlHDswQnu+1nQHE0F/oboD0Q9Z
hOvXAr1L7LWu0hkLV7BqmeI0SPcRA3b5MU3dfaTK8MaPAo8anQTpCyYUnoIBqX8h
y324T/dvpFKq2/X3RL+wOSYTA8TLgyhH0fhdIKZg3G8m9kxuAHZYHIHnDtvgJ5yd
72tNY+w8UIX8U2ark/WdkAMZr3O0AuTDlvHcasxO5+puAu8jh0EgtqItqrvKwiF7
dmlHVW41Rt+su2fmsUkk4Z0IhWrn3PdrSWAcH2eL6vjuqx6CccpjsjyiSQ90dUox
EoMpY+viX59aF0kU4BLt76mQO6YZtCpicLxFGCu97v1mNn+FWjhBOIF08pVsbNlq
oMl2j0N8NKZxJvkkmsA/i//ch5FsjzvUy3xajlSzq9ruWS4SlWq2Vzdx/acvF7Oa
ABA11wIjzLc9vmhzQNiRa53fJQwi+w/Or9LtH2msKCbcPVHoZ5OT4t6S8QARAQAB
tBpMYXVuY2hwYWQgUFBBIGZvciBPREwgVGVhbYkCOAQTAQIAIgUCWIpoEQIbAwYL
CQgHAwIGFQgCCQoLBBYCAwECHgECF4AACgkQe4qho0TAUkgAmg//XY/RqU4WcT+p
13oDc3+Dp4aL+rwaNz0o56i0z0cYPxd8GPicCuS8d/di07GnQiBcZ5DZgegnnaYm
OUF+phxk4q+jYO/t2GHQlYSf/QyUv7OimidLOHN1FiahmcGobliwih70o6ZcMT84
ggSu8jBzA/HLFBIkgStKD/staR5zJ2HfK298yVhiffyrPA+I3nPe7pvTaGa2e8AP
BYs5zB5n27upSZIokXFvqlmS4HEKDmPcY061wgmg1cNY1Y+mIuGjxY1Igbi6kAe0
yaLN2AN4c2ImhpwOcuazKTe/q2ZhoPTpYvuzmogwau8LBjRBhVS6fkTpSBPEkcwn
f/QYmmVLygmpMDHuHapyH8iaUoksq7gd64iBRDJQN7giQSjkTVvcGBqoKG8lbUMV
MDT4FGuYYsObWUg7kmHlNq9nIVlAxmxv8ZTg9+8xy3f53aId/51m+gW9LGRAT94T
ZIWrF9cBvsPWoHgHkV1At/fPprOvNXqeQiJ7UzC3ikDNCu2AjPEbA4sb019RNgtj
jUI6g6RZdzbeKVpptxILCtT3yKbfKj8AfrfaRzS0yMhVudgLolIUA4S6g46p0Cgy
gITO49wxxBu6UAOsAG3psDRlsZmmrT4AH09Yt2RzmY0FBWValqpoPagheQqeU+2W
FKnV9Lw1SKMtWZbYMvIlB0rwts3k9lE=
=xkZ9
-----END PGP PUBLIC KEY BLOCK-----
EOF] at time 02:11:40.867716 duration_in_ms=279.686
2019-09-02 02:11:40,871 [salt.state       :1780][INFO    ][5231] Running state [deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main] at time 02:11:40.871048
2019-09-02 02:11:40,871 [salt.state       :1813][INFO    ][5231] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main]
2019-09-02 02:11:40,967 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-09-02 02:11:44,888 [salt.state       :300 ][INFO    ][5231] {'repo': 'deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main'}
2019-09-02 02:11:44,888 [salt.state       :1951][INFO    ][5231] Completed state [deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main] at time 02:11:44.888876 duration_in_ms=4017.828
2019-09-02 02:11:44,890 [salt.state       :1780][INFO    ][5231] Running state [opendaylight] at time 02:11:44.890500
2019-09-02 02:11:44,891 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-09-02 02:11:45,248 [salt.state       :1780][INFO    ][5231] Running state [opendaylight] at time 02:11:45.248602
2019-09-02 02:11:45,249 [salt.state       :1813][INFO    ][5231] Executing state service.masked for [opendaylight]
2019-09-02 02:11:45,249 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2019-09-02 02:11:45,273 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['systemd-run', '--scope', 'systemctl', 'mask', 'opendaylight.service'] in directory '/root'
2019-09-02 02:11:45,370 [salt.state       :300 ][INFO    ][5231] Made the following changes:
'masked' changed from 'False' to 'True'

2019-09-02 02:11:45,371 [salt.state       :1951][INFO    ][5231] Completed state [opendaylight] at time 02:11:45.371202 duration_in_ms=122.6
2019-09-02 02:11:45,372 [salt.state       :1780][INFO    ][5231] Running state [opendaylight] at time 02:11:45.372120
2019-09-02 02:11:45,372 [salt.state       :1813][INFO    ][5231] Executing state pkg.installed for [opendaylight]
2019-09-02 02:11:45,400 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-09-02 02:11:45,420 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight'] in directory '/root'
2019-09-02 02:11:49,432 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021149424822
2019-09-02 02:11:49,446 [salt.minion      :1432][INFO    ][5884] Starting a new job with PID 5884
2019-09-02 02:11:49,460 [salt.minion      :1711][INFO    ][5884] Returning information for job: 20190902021149424822
2019-09-02 02:12:19,590 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021219582113
2019-09-02 02:12:19,668 [salt.minion      :1432][INFO    ][5889] Starting a new job with PID 5889
2019-09-02 02:12:19,696 [salt.minion      :1711][INFO    ][5889] Returning information for job: 20190902021219582113
2019-09-02 02:12:49,657 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021249649296
2019-09-02 02:12:49,703 [salt.minion      :1432][INFO    ][5894] Starting a new job with PID 5894
2019-09-02 02:12:49,726 [salt.minion      :1711][INFO    ][5894] Returning information for job: 20190902021249649296
2019-09-02 02:13:19,865 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021319852907
2019-09-02 02:13:19,932 [salt.minion      :1432][INFO    ][5899] Starting a new job with PID 5899
2019-09-02 02:13:20,007 [salt.minion      :1711][INFO    ][5899] Returning information for job: 20190902021319852907
2019-09-02 02:13:49,956 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021349947679
2019-09-02 02:13:50,014 [salt.minion      :1432][INFO    ][5904] Starting a new job with PID 5904
2019-09-02 02:13:50,032 [salt.minion      :1711][INFO    ][5904] Returning information for job: 20190902021349947679
2019-09-02 02:14:20,170 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021420161418
2019-09-02 02:14:20,197 [salt.minion      :1432][INFO    ][5909] Starting a new job with PID 5909
2019-09-02 02:14:20,221 [salt.minion      :1711][INFO    ][5909] Returning information for job: 20190902021420161418
2019-09-02 02:14:50,355 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021450347181
2019-09-02 02:14:50,372 [salt.minion      :1432][INFO    ][5914] Starting a new job with PID 5914
2019-09-02 02:14:50,390 [salt.minion      :1711][INFO    ][5914] Returning information for job: 20190902021450347181
2019-09-02 02:15:20,527 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021520518795
2019-09-02 02:15:20,624 [salt.minion      :1432][INFO    ][5919] Starting a new job with PID 5919
2019-09-02 02:15:20,698 [salt.minion      :1711][INFO    ][5919] Returning information for job: 20190902021520518795
2019-09-02 02:15:50,627 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021550618166
2019-09-02 02:15:50,703 [salt.minion      :1432][INFO    ][5924] Starting a new job with PID 5924
2019-09-02 02:15:50,775 [salt.minion      :1711][INFO    ][5924] Returning information for job: 20190902021550618166
2019-09-02 02:16:20,705 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021620697811
2019-09-02 02:16:20,749 [salt.minion      :1432][INFO    ][5929] Starting a new job with PID 5929
2019-09-02 02:16:20,766 [salt.minion      :1711][INFO    ][5929] Returning information for job: 20190902021620697811
2019-09-02 02:16:50,909 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021650900728
2019-09-02 02:16:50,924 [salt.minion      :1432][INFO    ][5966] Starting a new job with PID 5966
2019-09-02 02:16:50,944 [salt.minion      :1711][INFO    ][5966] Returning information for job: 20190902021650900728
2019-09-02 02:17:20,932 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command saltutil.find_job with jid 20190902021720924568
2019-09-02 02:17:20,945 [salt.minion      :1432][INFO    ][7437] Starting a new job with PID 7437
2019-09-02 02:17:20,961 [salt.minion      :1711][INFO    ][7437] Returning information for job: 20190902021720924568
2019-09-02 02:17:24,022 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-09-02 02:17:24,058 [salt.state       :300 ][INFO    ][5231] Made the following changes:
'java-common' changed from 'absent' to '0.56ubuntu2'
'libxtst6' changed from 'absent' to '2:1.2.2-1'
'liblcms2-2' changed from 'absent' to '2.6-3ubuntu2.1'
'openjdk-8-jre-headless' changed from 'absent' to '8u222-b10-1ubuntu1~16.04.1'
'libxrender1' changed from 'absent' to '1:0.9.9-0ubuntu1'
'libavahi-common3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2.3'
'libnspr4' changed from 'absent' to '2:4.13.1-0ubuntu0.16.04.1'
'libfontconfig' changed from 'absent' to '1'
'fonts-dejavu-core' changed from 'absent' to '2.35-1'
'libnss3-nssdb' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.6'
'java8-runtime-headless' changed from 'absent' to '1'
'libcups2' changed from 'absent' to '2.1.3-4ubuntu0.10'
'libjpeg-turbo8' changed from 'absent' to '1.4.2-0ubuntu3.1'
'libavahi-client3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2.3'
'libnss3' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.6'
'libpcsclite1' changed from 'absent' to '1.8.14-1ubuntu1.16.04.1'
'java7-runtime-headless' changed from 'absent' to '1'
'ca-certificates-java' changed from 'absent' to '20160321ubuntu1'
'java2-runtime-headless' changed from 'absent' to '1'
'fontconfig-config' changed from 'absent' to '2.11.94-0ubuntu1.1'
'libavahi-common-data' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2.3'
'libxi6' changed from 'absent' to '2:1.7.6-1'
'java5-runtime-headless' changed from 'absent' to '1'
'java6-runtime-headless' changed from 'absent' to '1'
'x11-common' changed from 'absent' to '1:7.7+13ubuntu3.1'
'libjpeg8' changed from 'absent' to '8c-2ubuntu8'
'opendaylight' changed from 'absent' to '9.0.0-1ppa2'
'libfontconfig1' changed from 'absent' to '2.11.94-0ubuntu1.1'

2019-09-02 02:17:24,077 [salt.state       :915 ][INFO    ][5231] Loading fresh modules for state activity
2019-09-02 02:17:24,120 [salt.state       :1951][INFO    ][5231] Completed state [opendaylight] at time 02:17:24.120035 duration_in_ms=338747.914
2019-09-02 02:17:24,123 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/jetty.xml] at time 02:17:24.123789
2019-09-02 02:17:24,124 [salt.state       :1813][INFO    ][5231] Executing state file.managed for [/opt/opendaylight/etc/jetty.xml]
2019-09-02 02:17:24,152 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
2019-09-02 02:17:24,185 [salt.state       :300 ][INFO    ][5231] File changed:
--- 
+++ 
@@ -79,11 +79,11 @@
                         </Item>
                     </Array>
                 </Arg>
-                <Set name="host">
+                <Set name="host">172.16.10.40
                     <Property name="jetty.host"/>
                 </Set>
                 <Set name="port">
-                    <Property name="jetty.port" default="8181"/>
+                    <Property name="jetty.port" default="8282"/>
                 </Set>
                 <Set name="idleTimeout">
                     <Property name="http.timeout" default="300000"/>

2019-09-02 02:17:24,185 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/jetty.xml] at time 02:17:24.185913 duration_in_ms=62.123
2019-09-02 02:17:24,186 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/bin/setenv] at time 02:17:24.186300
2019-09-02 02:17:24,186 [salt.state       :1813][INFO    ][5231] Executing state file.managed for [/opt/opendaylight/bin/setenv]
2019-09-02 02:17:24,201 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
2019-09-02 02:17:24,224 [salt.state       :300 ][INFO    ][5231] File changed:
--- 
+++ 
@@ -1,55 +1,19 @@
-#!/bin/sh
-#
-#    Licensed to the Apache Software Foundation (ASF) under one or more
-#    contributor license agreements.  See the NOTICE file distributed with
-#    this work for additional information regarding copyright ownership.
-#    The ASF licenses this file to You under the Apache License, Version 2.0
-#    (the "License"); you may not use this file except in compliance with
-#    the License.  You may obtain a copy of the License at
-#
-#       http://www.apache.org/licenses/LICENSE-2.0
-#
-#    Unless required by applicable law or agreed to in writing, software
-#    distributed under the License is distributed on an "AS IS" BASIS,
-#    WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
-#    See the License for the specific language governing permissions and
-#    limitations under the License.
-#
-
-#
-# handle specific scripts; the SCRIPT_NAME is exactly the name of the Karaf
-# script: client, instance, shell, start, status, stop, karaf
-#
-# if [ "${KARAF_SCRIPT}" == "SCRIPT_NAME" ]; then
-#   Actions go here...
-# fi
-
-#
-# general settings which should be applied for all scripts go here; please keep
-# in mind that it is possible that scripts might be executed more than once, e.g.
-# in example of the start script where the start script is executed first and the
-# karaf script afterwards.
-#
-
-#
-# The following section shows the possible configuration options for the default 
-# karaf scripts
-#
-# export JAVA_HOME # Location of Java installation
-# export JAVA_MIN_MEM # Minimum memory for the JVM
-# export JAVA_MAX_MEM # Maximum memory for the JVM
+##############################################################################
+# Copyright (c) 2017 Mirantis Inc. and others.
+# All rights reserved. This program and the accompanying materials
+# are made available under the terms of the Apache License, Version 2.0
+# which accompanies this distribution, and is available at
+# http://www.apache.org/licenses/LICENSE-2.0
+############################################################################### export JAVA_HOME # Location of Java installation
+export JAVA_MIN_MEM=4g # Minimum memory for the JVM
+export JAVA_MAX_MEM=4g # Maximum memory for the JVM
 # export JAVA_PERM_MEM # Minimum perm memory for the JVM
-# export JAVA_MAX_PERM_MEM # Maximum perm memory for the JVM
-# export EXTRA_JAVA_OPTS # Additional JVM options
+export JAVA_MAX_PERM_MEM=512m # Maximum perm memory for the JVM
+export EXTRA_JAVA_OPTS='-Djava.net.preferIPv4Stack=true -XX:+UseG1GC' # Additional JVM options
 # export KARAF_HOME # Karaf home folder
 # export KARAF_DATA # Karaf data folder
 # export KARAF_BASE # Karaf base folder
 # export KARAF_ETC  # Karaf etc  folder
-# export KARAF_SYSTEM_OPTS # First citizen Karaf options
 # export KARAF_OPTS # Additional available Karaf options
 # export KARAF_DEBUG # Enable debug mode
 # export KARAF_REDIRECT # Enable/set the std/err redirection when using bin/start
-# export KARAF_NOROOT # Prevent execution as root if set to true
-if [ "x$JAVA_MAX_MEM" = "x" ]; then
-    export JAVA_MAX_MEM="2048m"
-fi

2019-09-02 02:17:24,225 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/bin/setenv] at time 02:17:24.224994 duration_in_ms=38.694
2019-09-02 02:17:24,229 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 02:17:24.229185
2019-09-02 02:17:24,229 [salt.state       :1813][INFO    ][5231] Executing state ini.options_present for [/opt/opendaylight/etc/org.apache.karaf.features.cfg]
2019-09-02 02:17:24,249 [salt.state       :300 ][INFO    ][5231] {'featuresBoot': {'after': 'standard,wrap,ssh,odl-restconf-all,odl-aaa-authn,odl-netvirt-openstack', 'before': 'c356856b-baa8-4437-a4b1-6f6fb032f029'}}
2019-09-02 02:17:24,249 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 02:17:24.249715 duration_in_ms=20.53
2019-09-02 02:17:24,250 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 02:17:24.250065
2019-09-02 02:17:24,250 [salt.state       :1813][INFO    ][5231] Executing state ini.options_present for [/opt/opendaylight/etc/org.ops4j.pax.web.cfg]
2019-09-02 02:17:24,251 [salt.state       :300 ][INFO    ][5231] {'org.osgi.service.http.port': {'after': '8282', 'before': '8181'}, 'org.ops4j.pax.web.listening.addresses': {'after': '172.16.10.40', 'before': None}}
2019-09-02 02:17:24,251 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 02:17:24.251836 duration_in_ms=1.77
2019-09-02 02:17:24,252 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.252181
2019-09-02 02:17:24,252 [salt.state       :1813][INFO    ][5231] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-02 02:17:24,257 [salt.state       :300 ][INFO    ][5231] File changed:
--- 
+++ 
@@ -26,7 +26,7 @@
 #log4j2.rootLogger.type = asyncRoot
 #log4j2.rootLogger.includeLocation = false
 log4j2.rootLogger.appenderRef.RollingFile.ref = RollingFile
-log4j2.rootLogger.appenderRef.PaxOsgi.ref = PaxOsgi
+#log4j2.rootLogger.appenderRef.PaxOsgi.ref = PaxOsgi
 log4j2.rootLogger.appenderRef.Console.ref = Console
 log4j2.rootLogger.appenderRef.Console.filter.threshold.type = ThresholdFilter
 log4j2.rootLogger.appenderRef.Console.filter.threshold.level = ${karaf.log.console:-OFF}

2019-09-02 02:17:24,258 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.258075 duration_in_ms=5.894
2019-09-02 02:17:24,258 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.258416
2019-09-02 02:17:24,258 [salt.state       :1813][INFO    ][5231] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-02 02:17:24,263 [salt.state       :300 ][INFO    ][5231] File changed:
--- 
+++ 
@@ -78,7 +78,7 @@
 log4j2.appender.audit.policies.size.size = 8MB
 
 # OSGi appender
-log4j2.appender.osgi.type = PaxOsgi
+#log4j2.appender.osgi.type = PaxOsgi
 log4j2.appender.osgi.name = PaxOsgi
 log4j2.appender.osgi.filter = *
 

2019-09-02 02:17:24,263 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.263580 duration_in_ms=5.164
2019-09-02 02:17:24,263 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.263925
2019-09-02 02:17:24,264 [salt.state       :1813][INFO    ][5231] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-02 02:17:24,268 [salt.state       :300 ][INFO    ][5231] File changed:
--- 
+++ 
@@ -79,7 +79,7 @@
 
 # OSGi appender
 #log4j2.appender.osgi.type = PaxOsgi
-log4j2.appender.osgi.name = PaxOsgi
+#log4j2.appender.osgi.name = PaxOsgi
 log4j2.appender.osgi.filter = *
 
 # help with identification of maven-related problems with pax-url-aether

2019-09-02 02:17:24,269 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.268985 duration_in_ms=5.06
2019-09-02 02:17:24,269 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.269327
2019-09-02 02:17:24,269 [salt.state       :1813][INFO    ][5231] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-02 02:17:24,274 [salt.state       :300 ][INFO    ][5231] File changed:
--- 
+++ 
@@ -80,7 +80,7 @@
 # OSGi appender
 #log4j2.appender.osgi.type = PaxOsgi
 #log4j2.appender.osgi.name = PaxOsgi
-log4j2.appender.osgi.filter = *
+#log4j2.appender.osgi.filter = *
 
 # help with identification of maven-related problems with pax-url-aether
 #log4j2.logger.aether.name = shaded.org.eclipse.aether

2019-09-02 02:17:24,274 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 02:17:24.274398 duration_in_ms=5.07
2019-09-02 02:17:24,274 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 02:17:24.274757
2019-09-02 02:17:24,275 [salt.state       :1813][INFO    ][5231] Executing state file.managed for [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg]
2019-09-02 02:17:24,275 [salt.loaded.int.states.file:2298][WARNING ][5231] State for file: /opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-09-02 02:17:24,276 [salt.state       :300 ][INFO    ][5231] {'new': 'file /opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg created', 'group': 'odl', 'user': 'odl'}
2019-09-02 02:17:24,276 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 02:17:24.276468 duration_in_ms=1.711
2019-09-02 02:17:24,276 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 02:17:24.276805
2019-09-02 02:17:24,277 [salt.state       :1813][INFO    ][5231] Executing state ini.options_present for [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg]
2019-09-02 02:17:24,277 [salt.state       :300 ][INFO    ][5231] {'is-statistics-polling-on': {'after': 'False', 'before': None}}
2019-09-02 02:17:24,277 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 02:17:24.277763 duration_in_ms=0.958
2019-09-02 02:17:24,278 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/custom.properties] at time 02:17:24.278097
2019-09-02 02:17:24,278 [salt.state       :1813][INFO    ][5231] Executing state ini.options_present for [/opt/opendaylight/etc/custom.properties]
2019-09-02 02:17:24,308 [salt.state       :300 ][INFO    ][5231] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': '1.3', 'before': None}}
2019-09-02 02:17:24,308 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/custom.properties] at time 02:17:24.308338 duration_in_ms=30.241
2019-09-02 02:17:24,308 [salt.state       :1780][INFO    ][5231] Running state [/opt/opendaylight/etc/opendaylight/datastore/initial/config/netvirt-natservice-config.xml] at time 02:17:24.308687
2019-09-02 02:17:24,308 [salt.state       :1813][INFO    ][5231] Executing state file.managed for [/opt/opendaylight/etc/opendaylight/datastore/initial/config/netvirt-natservice-config.xml]
2019-09-02 02:17:24,324 [salt.fileclient  :1219][INFO    ][5231] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/netvirt-natservice-config.xml'
2019-09-02 02:17:24,351 [salt.state       :300 ][INFO    ][5231] File changed:
New file
2019-09-02 02:17:24,351 [salt.state       :1951][INFO    ][5231] Completed state [/opt/opendaylight/etc/opendaylight/datastore/initial/config/netvirt-natservice-config.xml] at time 02:17:24.351328 duration_in_ms=42.64
2019-09-02 02:17:24,816 [salt.state       :1780][INFO    ][5231] Running state [opendaylight] at time 02:17:24.816096
2019-09-02 02:17:24,816 [salt.state       :1813][INFO    ][5231] Executing state service.running for [opendaylight]
2019-09-02 02:17:24,817 [salt.state       :302 ][ERROR   ][5231] The named service opendaylight is not available
2019-09-02 02:17:24,817 [salt.state       :1951][INFO    ][5231] Completed state [opendaylight] at time 02:17:24.817769 duration_in_ms=1.674
2019-09-02 02:17:24,818 [salt.state       :1780][INFO    ][5231] Running state [opendaylight] at time 02:17:24.817976
2019-09-02 02:17:24,818 [salt.state       :1813][INFO    ][5231] Executing state service.mod_watch for [opendaylight]
2019-09-02 02:17:24,818 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2019-09-02 02:17:24,831 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'opendaylight.service'] in directory '/root'
2019-09-02 02:17:24,865 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['systemd-run', '--scope', 'systemctl', 'unmask', 'opendaylight.service'] in directory '/root'
2019-09-02 02:17:24,964 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5231] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'opendaylight.service'] in directory '/root'
2019-09-02 02:17:25,010 [salt.state       :300 ][INFO    ][5231] {'opendaylight': True}
2019-09-02 02:17:25,011 [salt.state       :1951][INFO    ][5231] Completed state [opendaylight] at time 02:17:25.011136 duration_in_ms=193.16
2019-09-02 02:17:25,016 [salt.minion      :1711][INFO    ][5231] Returning information for job: 20190902021134366985
2019-09-02 02:17:25,523 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command pillar.get with jid 20190902021725515216
2019-09-02 02:17:25,535 [salt.minion      :1432][INFO    ][9274] Starting a new job with PID 9274
2019-09-02 02:17:25,540 [salt.minion      :1711][INFO    ][9274] Returning information for job: 20190902021725515216
2019-09-02 02:17:26,016 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command pillar.get with jid 20190902021726008068
2019-09-02 02:17:26,028 [salt.minion      :1432][INFO    ][9280] Starting a new job with PID 9280
2019-09-02 02:17:26,034 [salt.minion      :1711][INFO    ][9280] Returning information for job: 20190902021726008068
2019-09-02 02:46:41,146 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command cp.push_dir with jid 20190902024641134405
2019-09-02 02:46:41,617 [salt.minion      :1432][INFO    ][9912] Starting a new job with PID 9912
2019-09-02 02:46:41,879 [salt.minion      :1711][INFO    ][9912] Returning information for job: 20190902024641134405
2019-09-02 03:11:04,302 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 04:11:04,281 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 05:11:04,276 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 06:11:04,270 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 07:11:04,271 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 08:11:04,271 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 09:11:04,270 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 10:11:04,270 [salt.utils.schedule:1377][INFO    ][5141] Running scheduled job: __mine_interval
2019-09-02 10:17:36,983 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command grains.get with jid 20190902101736947367
2019-09-02 10:17:37,053 [salt.minion      :1432][INFO    ][16147] Starting a new job with PID 16147
2019-09-02 10:17:37,069 [salt.minion      :1711][INFO    ][16147] Returning information for job: 20190902101736947367
2019-09-02 11:06:29,105 [salt.minion      :1308][INFO    ][5141] User sudo_ubuntu Executing command cp.push_dir with jid 20190902110629095161
2019-09-02 11:06:29,398 [salt.minion      :1432][INFO    ][16732] Starting a new job with PID 16732
