2019-09-29 18:04:52,116 [salt.utils       :831 ][ERROR   ][1631] DNS lookup or connection check of 'salt' failed.
2019-09-29 18:04:52,116 [salt.minion      :152 ][ERROR   ][1631] Master hostname: 'salt' not found or not responsive. Retrying in 30 seconds
2019-09-29 18:04:55,386 [salt.utils.parsers:1051][WARNING ][1631] Minion received a SIGTERM. Exiting.
2019-09-29 18:06:29,054 [salt.utils.decorators:613 ][WARNING ][2063] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-29 18:06:47,154 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:57,920 [salt.utils.decorators:613 ][WARNING ][2063] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-29 18:06:58,025 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:58,027 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:58,029 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:58,030 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:58,032 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:58,033 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:58,034 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:06:58,036 [salt.loaded.int.states.file:2298][WARNING ][2063] 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-29 18:07:03,423 [salt.loaded.int.module.debian_ip:1964][WARNING ][2063] The network state sls is requiring a reboot of the system to properly apply network configuration.
2019-09-29 18:07:03,636 [salt.loaded.int.module.cmdmod:730 ][ERROR   ][2063] Command '['umount', '/dev/shm']' failed with return code: 32
2019-09-29 18:07:03,637 [salt.loaded.int.module.cmdmod:734 ][ERROR   ][2063] 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-29 18:07:03,637 [salt.loaded.int.module.cmdmod:736 ][ERROR   ][2063] retcode: 32
2019-09-29 18:07:16,076 [salt.utils.parsers:1051][WARNING ][1846] Minion received a SIGTERM. Exiting.
2019-09-29 18:09:14,626 [salt.utils.decorators:613 ][WARNING ][3614] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-09-29 18:09:24,919 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5160] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-09-29 18:09:24,942 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5160] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-09-29 18:09:24,958 [salt.utils.parsers:1051][WARNING ][2059] Minion received a SIGTERM. Exiting.
2019-09-29 18:09:25,966 [salt.cli.daemons :293 ][INFO    ][5215] Setting up the Salt Minion "odl01.mcp-odl-noha.local"
2019-09-29 18:09:26,157 [salt.cli.daemons :82  ][INFO    ][5215] Starting up the Salt Minion
2019-09-29 18:09:26,158 [salt.utils.event :1017][INFO    ][5215] Starting pull socket on /var/run/salt/minion/minion_event_0d1d1cf3c0_pull.ipc
2019-09-29 18:09:26,739 [salt.minion      :976 ][INFO    ][5215] Creating minion process manager
2019-09-29 18:09:27,943 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][5215] Executing command ['date', '+%z'] in directory '/root'
2019-09-29 18:09:27,966 [salt.utils.schedule:568 ][INFO    ][5215] Updating job settings for scheduled job: __mine_interval
2019-09-29 18:09:27,981 [salt.minion      :1108][INFO    ][5215] Added mine.update to scheduler
2019-09-29 18:09:28,038 [salt.minion      :1975][INFO    ][5215] Minion is starting as user 'root'
2019-09-29 18:09:28,054 [salt.minion      :2336][INFO    ][5215] Minion is ready to receive requests!
2019-09-29 18:10:04,158 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command state.sls with jid 20190929181004151066
2019-09-29 18:10:04,172 [salt.minion      :1432][INFO    ][5304] Starting a new job with PID 5304
2019-09-29 18:10:10,039 [salt.state       :915 ][INFO    ][5304] Loading fresh modules for state activity
2019-09-29 18:10:10,101 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
2019-09-29 18:10:10,136 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
2019-09-29 18:10:10,169 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2019-09-29 18:10:10,208 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/config.sls'
2019-09-29 18:10:10,276 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/repo.sls'
2019-09-29 18:10:10,999 [salt.state       :1780][INFO    ][5304] 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 18:10:10.999554
2019-09-29 18:10:11,000 [salt.state       :1813][INFO    ][5304] 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-29 18:10:11,001 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command 'apt-key list | grep -qF '4096R/44C05248 2017-01-26'' in directory '/root'
2019-09-29 18:10:11,103 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] 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-29 18:10:11,336 [salt.state       :300 ][INFO    ][5304] {'pid': 5366, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2019-09-29 18:10:11,337 [salt.state       :1951][INFO    ][5304] 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 18:10:11.337050 duration_in_ms=337.496
2019-09-29 18:10:11,340 [salt.state       :1780][INFO    ][5304] Running state [deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main] at time 18:10:11.340342
2019-09-29 18:10:11,340 [salt.state       :1813][INFO    ][5304] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main]
2019-09-29 18:10:11,429 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-09-29 18:10:15,377 [salt.state       :300 ][INFO    ][5304] {'repo': 'deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main'}
2019-09-29 18:10:15,378 [salt.state       :1951][INFO    ][5304] Completed state [deb http://ppa.launchpad.net/odl-team/fluorine/ubuntu xenial main] at time 18:10:15.377935 duration_in_ms=4037.593
2019-09-29 18:10:15,379 [salt.state       :1780][INFO    ][5304] Running state [opendaylight] at time 18:10:15.379507
2019-09-29 18:10:15,380 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-09-29 18:10:15,809 [salt.state       :1780][INFO    ][5304] Running state [opendaylight] at time 18:10:15.808919
2019-09-29 18:10:15,809 [salt.state       :1813][INFO    ][5304] Executing state service.masked for [opendaylight]
2019-09-29 18:10:15,810 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2019-09-29 18:10:15,853 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['systemd-run', '--scope', 'systemctl', 'mask', 'opendaylight.service'] in directory '/root'
2019-09-29 18:10:15,966 [salt.state       :300 ][INFO    ][5304] Made the following changes:
'masked' changed from 'False' to 'True'

2019-09-29 18:10:15,967 [salt.state       :1951][INFO    ][5304] Completed state [opendaylight] at time 18:10:15.967139 duration_in_ms=158.22
2019-09-29 18:10:15,968 [salt.state       :1780][INFO    ][5304] Running state [opendaylight] at time 18:10:15.968018
2019-09-29 18:10:15,968 [salt.state       :1813][INFO    ][5304] Executing state pkg.installed for [opendaylight]
2019-09-29 18:10:16,000 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-09-29 18:10:16,025 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] 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-29 18:10:19,212 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command saltutil.find_job with jid 20190929181019199817
2019-09-29 18:10:19,231 [salt.minion      :1432][INFO    ][5957] Starting a new job with PID 5957
2019-09-29 18:10:19,248 [salt.minion      :1711][INFO    ][5957] Returning information for job: 20190929181019199817
2019-09-29 18:10:49,241 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command saltutil.find_job with jid 20190929181049232786
2019-09-29 18:10:49,256 [salt.minion      :1432][INFO    ][6183] Starting a new job with PID 6183
2019-09-29 18:10:49,273 [salt.minion      :1711][INFO    ][6183] Returning information for job: 20190929181049232786
2019-09-29 18:10:56,631 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-09-29 18:10:56,668 [salt.state       :300 ][INFO    ][5304] 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-29 18:10:56,687 [salt.state       :915 ][INFO    ][5304] Loading fresh modules for state activity
2019-09-29 18:10:56,729 [salt.state       :1951][INFO    ][5304] Completed state [opendaylight] at time 18:10:56.729680 duration_in_ms=40761.661
2019-09-29 18:10:56,734 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/jetty.xml] at time 18:10:56.734937
2019-09-29 18:10:56,735 [salt.state       :1813][INFO    ][5304] Executing state file.managed for [/opt/opendaylight/etc/jetty.xml]
2019-09-29 18:10:56,771 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
2019-09-29 18:10:56,806 [salt.state       :300 ][INFO    ][5304] 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-29 18:10:56,806 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/jetty.xml] at time 18:10:56.806884 duration_in_ms=71.947
2019-09-29 18:10:56,807 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/bin/setenv] at time 18:10:56.807253
2019-09-29 18:10:56,807 [salt.state       :1813][INFO    ][5304] Executing state file.managed for [/opt/opendaylight/bin/setenv]
2019-09-29 18:10:56,827 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
2019-09-29 18:10:56,857 [salt.state       :300 ][INFO    ][5304] 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-29 18:10:56,857 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/bin/setenv] at time 18:10:56.857341 duration_in_ms=50.087
2019-09-29 18:10:56,862 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 18:10:56.862311
2019-09-29 18:10:56,862 [salt.state       :1813][INFO    ][5304] Executing state ini.options_present for [/opt/opendaylight/etc/org.apache.karaf.features.cfg]
2019-09-29 18:10:56,882 [salt.state       :300 ][INFO    ][5304] {'featuresBoot': {'after': 'standard,wrap,ssh,odl-restconf-all,odl-aaa-authn,odl-netvirt-openstack', 'before': 'c356856b-baa8-4437-a4b1-6f6fb032f029'}}
2019-09-29 18:10:56,882 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 18:10:56.882523 duration_in_ms=20.212
2019-09-29 18:10:56,882 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 18:10:56.882857
2019-09-29 18:10:56,883 [salt.state       :1813][INFO    ][5304] Executing state ini.options_present for [/opt/opendaylight/etc/org.ops4j.pax.web.cfg]
2019-09-29 18:10:56,884 [salt.state       :300 ][INFO    ][5304] {'org.osgi.service.http.port': {'after': '8282', 'before': '8181'}, 'org.ops4j.pax.web.listening.addresses': {'after': '172.16.10.40', 'before': None}}
2019-09-29 18:10:56,884 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 18:10:56.884635 duration_in_ms=1.777
2019-09-29 18:10:56,885 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.884975
2019-09-29 18:10:56,885 [salt.state       :1813][INFO    ][5304] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-29 18:10:56,891 [salt.state       :300 ][INFO    ][5304] 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-29 18:10:56,891 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.891316 duration_in_ms=6.341
2019-09-29 18:10:56,891 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.891776
2019-09-29 18:10:56,892 [salt.state       :1813][INFO    ][5304] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-29 18:10:56,896 [salt.state       :300 ][INFO    ][5304] 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-29 18:10:56,896 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.896803 duration_in_ms=5.027
2019-09-29 18:10:56,897 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.897140
2019-09-29 18:10:56,897 [salt.state       :1813][INFO    ][5304] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-29 18:10:56,902 [salt.state       :300 ][INFO    ][5304] 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-29 18:10:56,902 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.902739 duration_in_ms=5.599
2019-09-29 18:10:56,903 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.903078
2019-09-29 18:10:56,903 [salt.state       :1813][INFO    ][5304] Executing state file.comment for [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg]
2019-09-29 18:10:56,907 [salt.state       :300 ][INFO    ][5304] 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-29 18:10:56,908 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.ops4j.pax.logging.cfg] at time 18:10:56.908042 duration_in_ms=4.964
2019-09-29 18:10:56,908 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 18:10:56.908383
2019-09-29 18:10:56,908 [salt.state       :1813][INFO    ][5304] Executing state file.managed for [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg]
2019-09-29 18:10:56,908 [salt.loaded.int.states.file:2298][WARNING ][5304] 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-29 18:10:56,910 [salt.state       :300 ][INFO    ][5304] {'new': 'file /opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg created', 'group': 'odl', 'user': 'odl'}
2019-09-29 18:10:56,910 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 18:10:56.910388 duration_in_ms=2.004
2019-09-29 18:10:56,910 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 18:10:56.910774
2019-09-29 18:10:56,911 [salt.state       :1813][INFO    ][5304] Executing state ini.options_present for [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg]
2019-09-29 18:10:56,911 [salt.state       :300 ][INFO    ][5304] {'is-statistics-polling-on': {'after': 'False', 'before': None}}
2019-09-29 18:10:56,911 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/org.opendaylight.openflowplugin.cfg] at time 18:10:56.911857 duration_in_ms=1.083
2019-09-29 18:10:56,912 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/custom.properties] at time 18:10:56.912225
2019-09-29 18:10:56,912 [salt.state       :1813][INFO    ][5304] Executing state ini.options_present for [/opt/opendaylight/etc/custom.properties]
2019-09-29 18:10:56,946 [salt.state       :300 ][INFO    ][5304] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': '1.3', 'before': None}}
2019-09-29 18:10:56,946 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/custom.properties] at time 18:10:56.946803 duration_in_ms=34.578
2019-09-29 18:10:56,947 [salt.state       :1780][INFO    ][5304] Running state [/opt/opendaylight/etc/opendaylight/datastore/initial/config/netvirt-natservice-config.xml] at time 18:10:56.947178
2019-09-29 18:10:56,947 [salt.state       :1813][INFO    ][5304] Executing state file.managed for [/opt/opendaylight/etc/opendaylight/datastore/initial/config/netvirt-natservice-config.xml]
2019-09-29 18:10:56,967 [salt.fileclient  :1219][INFO    ][5304] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/netvirt-natservice-config.xml'
2019-09-29 18:10:57,020 [salt.state       :300 ][INFO    ][5304] File changed:
New file
2019-09-29 18:10:57,020 [salt.state       :1951][INFO    ][5304] Completed state [/opt/opendaylight/etc/opendaylight/datastore/initial/config/netvirt-natservice-config.xml] at time 18:10:57.020783 duration_in_ms=73.605
2019-09-29 18:10:57,493 [salt.state       :1780][INFO    ][5304] Running state [opendaylight] at time 18:10:57.493113
2019-09-29 18:10:57,493 [salt.state       :1813][INFO    ][5304] Executing state service.running for [opendaylight]
2019-09-29 18:10:57,494 [salt.state       :302 ][ERROR   ][5304] The named service opendaylight is not available
2019-09-29 18:10:57,495 [salt.state       :1951][INFO    ][5304] Completed state [opendaylight] at time 18:10:57.494981 duration_in_ms=1.869
2019-09-29 18:10:57,495 [salt.state       :1780][INFO    ][5304] Running state [opendaylight] at time 18:10:57.495211
2019-09-29 18:10:57,495 [salt.state       :1813][INFO    ][5304] Executing state service.mod_watch for [opendaylight]
2019-09-29 18:10:57,496 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2019-09-29 18:10:57,512 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'opendaylight.service'] in directory '/root'
2019-09-29 18:10:57,554 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['systemd-run', '--scope', 'systemctl', 'unmask', 'opendaylight.service'] in directory '/root'
2019-09-29 18:10:57,678 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5304] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'opendaylight.service'] in directory '/root'
2019-09-29 18:10:57,732 [salt.state       :300 ][INFO    ][5304] {'opendaylight': True}
2019-09-29 18:10:57,732 [salt.state       :1951][INFO    ][5304] Completed state [opendaylight] at time 18:10:57.732426 duration_in_ms=237.215
2019-09-29 18:10:57,737 [salt.minion      :1711][INFO    ][5304] Returning information for job: 20190929181004151066
2019-09-29 18:10:58,376 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command pillar.get with jid 20190929181058368948
2019-09-29 18:10:58,388 [salt.minion      :1432][INFO    ][9283] Starting a new job with PID 9283
2019-09-29 18:10:58,393 [salt.minion      :1711][INFO    ][9283] Returning information for job: 20190929181058368948
2019-09-29 18:10:58,951 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command pillar.get with jid 20190929181058943816
2019-09-29 18:10:58,963 [salt.minion      :1432][INFO    ][9292] Starting a new job with PID 9292
2019-09-29 18:10:58,970 [salt.minion      :1711][INFO    ][9292] Returning information for job: 20190929181058943816
2019-09-29 18:42:25,708 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command cp.push_dir with jid 20190929184225698740
2019-09-29 18:42:25,725 [salt.minion      :1432][INFO    ][10076] Starting a new job with PID 10076
2019-09-29 18:42:25,988 [salt.minion      :1711][INFO    ][10076] Returning information for job: 20190929184225698740
2019-09-29 19:09:29,058 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-29 20:09:29,057 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-29 21:09:29,058 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-29 22:09:29,057 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-29 23:09:29,057 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-30 00:09:29,058 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-30 01:09:29,057 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-30 02:09:29,059 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-30 03:09:29,058 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-30 04:09:29,058 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-30 04:44:22,996 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command grains.get with jid 20190930044422953995
2019-09-30 04:44:23,032 [salt.minion      :1432][INFO    ][17946] Starting a new job with PID 17946
2019-09-30 04:44:23,065 [salt.minion      :1711][INFO    ][17946] Returning information for job: 20190930044422953995
2019-09-30 05:09:29,058 [salt.utils.schedule:1377][INFO    ][5215] Running scheduled job: __mine_interval
2019-09-30 05:31:13,734 [salt.minion      :1308][INFO    ][5215] User sudo_ubuntu Executing command cp.push_dir with jid 20190930053113721923
2019-09-30 05:31:13,765 [salt.minion      :1432][INFO    ][18499] Starting a new job with PID 18499
