Bugzilla – Attachment 867406 Details for
Bug 1212025
Salt is failing due to openssl-1_1 update
Home
|
New
|
Browse
|
Search
|
[?]
|
Reports
|
Requests
|
IDP Log In
|
Forgot Password
salt minion log
salt-minion.txt (text/plain), 42.15 KB, created by
Jozef Pupava
on 2023-06-05 12:59:57 UTC
(
hide
)
Description:
salt minion log
Filename:
MIME Type:
Creator:
Jozef Pupava
Created:
2023-06-05 12:59:57 UTC
Size:
42.15 KB
patch
obsolete
>2023-06-05 05:37:12,408 [salt.cli.daemons :291 ][INFO ][4289] Setting up the Salt Minion "master" >2023-06-05 05:37:12,409 [salt.utils.process:244 ][INFO ][4289] pidfile: /var/run/process_responsibility_salt-minion.pid not found >2023-06-05 05:37:12,593 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'base64_encode' as a jinja filter >2023-06-05 05:37:12,594 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'base64_decode' as a jinja filter >2023-06-05 05:37:12,594 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'md5' as a jinja filter >2023-06-05 05:37:12,594 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'sha1' as a jinja filter >2023-06-05 05:37:12,594 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'sha256' as a jinja filter >2023-06-05 05:37:12,598 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'sha512' as a jinja filter >2023-06-05 05:37:12,599 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'hmac' as a jinja filter >2023-06-05 05:37:12,599 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'hmac_compute' as a jinja filter >2023-06-05 05:37:12,599 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'random_hash' as a jinja filter >2023-06-05 05:37:12,599 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'rand_str' as a jinja filter >2023-06-05 05:37:12,599 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'file_hashsum' as a jinja filter >2023-06-05 05:37:12,767 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'http_query' as a jinja filter >2023-06-05 05:37:12,770 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'strftime' as a jinja filter >2023-06-05 05:37:12,770 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'date_format' as a jinja filter >2023-06-05 05:37:12,780 [salt.utils.decorators.jinja:75 ][DEBUG ][4289] Marking 'raise' as a jinja global >2023-06-05 05:37:12,780 [salt.utils.decorators.jinja:51 ][DEBUG ][4289] Marking 'match' as a jinja test >2023-06-05 05:37:12,780 [salt.utils.decorators.jinja:51 ][DEBUG ][4289] Marking 'equalto' as a jinja test >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'skip' as a jinja filter >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'sequence' as a jinja filter >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'to_bool' as a jinja filter >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'indent' as a jinja filter >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'tojson' as a jinja filter >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'quote' as a jinja filter >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'regex_escape' as a jinja filter >2023-06-05 05:37:12,781 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'regex_search' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'regex_match' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'regex_replace' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'uuid' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'unique' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'min' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'max' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'avg' as a jinja filter >2023-06-05 05:37:12,782 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'union' as a jinja filter >2023-06-05 05:37:12,790 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'intersect' as a jinja filter >2023-06-05 05:37:12,791 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'difference' as a jinja filter >2023-06-05 05:37:12,791 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'symmetric_difference' as a jinja filter >2023-06-05 05:37:12,791 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'method_call' as a jinja filter >2023-06-05 05:37:12,791 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'yaml_dquote' as a jinja filter >2023-06-05 05:37:12,791 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'yaml_squote' as a jinja filter >2023-06-05 05:37:12,792 [salt.utils.decorators.jinja:27 ][DEBUG ][4289] Marking 'yaml_encode' as a jinja filter >2023-06-05 05:37:12,802 [salt.utils.process:316 ][DEBUG ][4289] Created pidfile: /var/run/salt-minion.pid >2023-06-05 05:37:12,807 [salt.cli.daemons :89 ][INFO ][4289] Starting up the Salt Minion >2023-06-05 05:37:12,808 [salt.utils.event :1098][DEBUG ][4289] AsyncEventPublisher PUB socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pub.ipc >2023-06-05 05:37:12,808 [salt.utils.event :1099][DEBUG ][4289] AsyncEventPublisher PULL socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:12,808 [salt.utils.event :1131][INFO ][4289] Starting pull socket on /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:12,809 [salt.utils.event :311 ][DEBUG ][4289] SaltEvent PUB socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pub.ipc >2023-06-05 05:37:12,810 [salt.utils.event :312 ][DEBUG ][4289] SaltEvent PULL socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:12,815 [salt.loader :896 ][DEBUG ][4289] Grains refresh requested. Refreshing grains. >2023-06-05 05:37:12,815 [salt.config :1933][DEBUG ][4289] Reading configuration from /etc/salt/minion >2023-06-05 05:37:12,958 [salt.utils.entrypoints:57 ][DEBUG ][4289] Using importlib_metadata to load entry points >2023-06-05 05:37:13,081 [salt.loader.lazy :857 ][DEBUG ][4289] Override __utils__: <module 'salt.loaded.int.grains.zfs' from '/usr/lib/python3.6/site-packages/salt/grains/zfs.py'> >2023-06-05 05:37:13,141 [salt.modules.network:2099][DEBUG ][4289] Unable to resolve address fe80::5054:ff:fe12:86c: [Errno 0] Resolver Error 0 (no error) >2023-06-05 05:37:13,235 [salt.modules.network:2135][DEBUG ][4289] Elapsed time getting FQDNs: 0.1339871883392334 seconds >2023-06-05 05:37:13,428 [salt.utils.lazy :99 ][DEBUG ][4289] LazyLoaded zfs.is_supported >2023-06-05 05:37:13,467 [salt.minion :1296][INFO ][4289] Creating minion process manager >2023-06-05 05:37:13,468 [salt.utils.process:645 ][DEBUG ][4289] Process Manager starting! >2023-06-05 05:37:13,469 [salt.utils.process:645 ][DEBUG ][4289] Process Manager starting! >2023-06-05 05:37:13,478 [salt.utils.entrypoints:57 ][DEBUG ][4289] Using importlib_metadata to load entry points >2023-06-05 05:37:13,528 [salt.minion :796 ][DEBUG ][4289] Connecting to master. Attempt 1 of 1 >2023-06-05 05:37:13,528 [salt.utils.network:2273][DEBUG ][4289] "localhost" Not an IP address? Assuming it is a hostname. >2023-06-05 05:37:13,529 [salt.minion :238 ][DEBUG ][4289] Master URI: tcp://127.0.0.1:4506 >2023-06-05 05:37:13,552 [salt.crypt :510 ][DEBUG ][4289] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:13,553 [salt.crypt :896 ][INFO ][4289] Generating keys: /etc/salt/pki/minion >2023-06-05 05:37:13,564 [salt.crypt :212 ][DEBUG ][4289] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:13,564 [salt.crypt :192 ][DEBUG ][4289] salt.crypt._get_key_with_evict: Loading private key >2023-06-05 05:37:13,566 [salt.crypt :904 ][DEBUG ][4289] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:13,567 [salt.transport.zeromq:429 ][DEBUG ][4289] Generated random reconnect delay between '1000ms' and '11000ms' (6963) >2023-06-05 05:37:13,568 [salt.transport.zeromq:432 ][DEBUG ][4289] Setting zmq_reconnect_ivl to '6963ms' >2023-06-05 05:37:13,568 [salt.transport.zeromq:438 ][DEBUG ][4289] Setting zmq_reconnect_ivl_max to '11000ms' >2023-06-05 05:37:13,568 [salt.transport.zeromq:160 ][DEBUG ][4289] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:13,569 [salt.transport.zeromq:1233][DEBUG ][4289] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:13,569 [salt.crypt :220 ][DEBUG ][4289] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:13,582 [salt.crypt :855 ][ERROR ][4289] The Salt Master has cached the public key for this node, this salt minion will wait for 10 seconds before attempting to re-authenticate >2023-06-05 05:37:13,582 [salt.crypt :680 ][INFO ][4289] Waiting 10 seconds before retry. >2023-06-05 05:37:23,583 [salt.crypt :220 ][DEBUG ][4289] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:23,594 [salt.crypt :855 ][ERROR ][4289] The Salt Master has cached the public key for this node, this salt minion will wait for 10 seconds before attempting to re-authenticate >2023-06-05 05:37:23,594 [salt.crypt :680 ][INFO ][4289] Waiting 10 seconds before retry. >2023-06-05 05:37:33,603 [salt.crypt :220 ][DEBUG ][4289] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:33,620 [salt.crypt :855 ][ERROR ][4289] The Salt Master has cached the public key for this node, this salt minion will wait for 10 seconds before attempting to re-authenticate >2023-06-05 05:37:33,620 [salt.crypt :680 ][INFO ][4289] Waiting 10 seconds before retry. >2023-06-05 05:37:43,631 [salt.crypt :220 ][DEBUG ][4289] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:43,651 [salt.crypt :978 ][DEBUG ][4289] Decrypting the current master AES key >2023-06-05 05:37:43,651 [salt.crypt :212 ][DEBUG ][4289] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:43,651 [salt.crypt :904 ][DEBUG ][4289] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:43,661 [salt.crypt :220 ][DEBUG ][4289] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:43,661 [salt.crypt :259 ][DEBUG ][4289] salt.crypt.verify_signature: Loading public key >2023-06-05 05:37:43,661 [salt.crypt :220 ][DEBUG ][4289] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:43,662 [salt.crypt :261 ][DEBUG ][4289] salt.crypt.verify_signature: Verifying signature >2023-06-05 05:37:43,662 [salt.crypt :705 ][DEBUG ][4289] <salt.crypt.AsyncAuth object at 0x7f399a1f9128> Got new master aes key. >2023-06-05 05:37:43,663 [salt.transport.zeromq:179 ][DEBUG ][4289] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:43,663 [salt.transport.zeromq:495 ][DEBUG ][4289] Connecting the Minion to the Master publish port, using the URI: tcp://127.0.0.1:4505 >2023-06-05 05:37:43,664 [salt.crypt :212 ][DEBUG ][4289] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:43,664 [salt.crypt :904 ][DEBUG ][4289] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:43,671 [salt.crypt :518 ][DEBUG ][4289] Re-using AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:43,671 [salt.transport.zeromq:160 ][DEBUG ][4289] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:43,671 [salt.transport.zeromq:1233][DEBUG ][4289] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:43,781 [salt.crypt :212 ][DEBUG ][4289] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:43,781 [salt.crypt :904 ][DEBUG ][4289] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:43,790 [salt.crypt :259 ][DEBUG ][4289] salt.crypt.verify_signature: Loading public key >2023-06-05 05:37:43,790 [salt.crypt :220 ][DEBUG ][4289] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:43,790 [salt.crypt :261 ][DEBUG ][4289] salt.crypt.verify_signature: Verifying signature >2023-06-05 05:37:43,790 [salt.transport.zeromq:179 ][DEBUG ][4289] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:43,791 [salt.loader :896 ][DEBUG ][4289] Grains refresh requested. Refreshing grains. >2023-06-05 05:37:43,791 [salt.config :1933][DEBUG ][4289] Reading configuration from /etc/salt/minion >2023-06-05 05:37:43,866 [salt.utils.entrypoints:57 ][DEBUG ][4289] Using importlib_metadata to load entry points >2023-06-05 05:37:43,904 [salt.loader.lazy :857 ][DEBUG ][4289] Override __utils__: <module 'salt.loaded.int.grains.zfs' from '/usr/lib/python3.6/site-packages/salt/grains/zfs.py'> >2023-06-05 05:37:43,923 [salt.modules.network:2099][DEBUG ][4289] Unable to resolve address fe80::5054:ff:fe12:86c: [Errno 0] Resolver Error 0 (no error) >2023-06-05 05:37:44,022 [salt.modules.network:2135][DEBUG ][4289] Elapsed time getting FQDNs: 0.10967516899108887 seconds >2023-06-05 05:37:44,196 [salt.utils.lazy :99 ][DEBUG ][4289] LazyLoaded zfs.is_supported >2023-06-05 05:37:44,275 [salt.utils.schedule:92 ][DEBUG ][4289] Initializing new Schedule >2023-06-05 05:37:44,287 [salt.utils.lazy :99 ][DEBUG ][4289] LazyLoaded timezone.get_offset >2023-06-05 05:37:44,288 [salt.utils.lazy :99 ][DEBUG ][4289] LazyLoaded cmd.run >2023-06-05 05:37:44,289 [salt.loader.localhost.int.module.cmdmod:417 ][INFO ][4289] Executing command date in directory '/root' >2023-06-05 05:37:44,294 [salt.loader.localhost.int.module.cmdmod:882 ][DEBUG ][4289] stdout: +0200 >2023-06-05 05:37:44,294 [salt.loader.localhost.int.module.cmdmod:1312][DEBUG ][4289] output: +0200 >2023-06-05 05:37:44,303 [salt.utils.lazy :99 ][DEBUG ][4289] LazyLoaded config.merge >2023-06-05 05:37:44,304 [salt.utils.event :311 ][DEBUG ][4289] SaltEvent PUB socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pub.ipc >2023-06-05 05:37:44,304 [salt.utils.event :312 ][DEBUG ][4289] SaltEvent PULL socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:44,306 [salt.utils.event :817 ][DEBUG ][4289] Sending event: tag = /salt/minion/minion_schedule_delete_complete; data = {'complete': True, 'schedule': {}, '_stamp': '2023-06-05T03:37:44.305960'} >2023-06-05 05:37:44,306 [salt.transport.ipc:370 ][DEBUG ][4289] Closing IPCMessageClient instance >2023-06-05 05:37:44,306 [salt.utils.schedule:300 ][DEBUG ][4289] Persisting schedule >2023-06-05 05:37:44,309 [salt.utils.lazy :99 ][DEBUG ][4289] LazyLoaded mine.update >2023-06-05 05:37:44,309 [salt.utils.schedule:406 ][INFO ][4289] Added new job __mine_interval to scheduler >2023-06-05 05:37:44,310 [salt.utils.event :311 ][DEBUG ][4289] SaltEvent PUB socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pub.ipc >2023-06-05 05:37:44,310 [salt.utils.event :312 ][DEBUG ][4289] SaltEvent PULL socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:44,311 [salt.utils.event :817 ][DEBUG ][4289] Sending event: tag = /salt/minion/minion_schedule_add_complete; data = {'complete': True, 'schedule': {'__mine_interval': {'function': 'mine.update', 'minutes': 60, 'jid_include': True, 'maxrunning': 2, 'run_on_start': True, 'return_job': False, 'enabled': True}}, '_stamp': '2023-06-05T03:37:44.310970'} >2023-06-05 05:37:44,311 [salt.transport.ipc:370 ][DEBUG ][4289] Closing IPCMessageClient instance >2023-06-05 05:37:44,311 [salt.utils.schedule:300 ][DEBUG ][4289] Persisting schedule >2023-06-05 05:37:44,312 [salt.minion :1443][INFO ][4289] Added mine.update to scheduler >2023-06-05 05:37:44,313 [salt.utils.event :311 ][DEBUG ][4289] SaltEvent PUB socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pub.ipc >2023-06-05 05:37:44,313 [salt.utils.event :312 ][DEBUG ][4289] SaltEvent PULL socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:44,314 [salt.utils.event :817 ][DEBUG ][4289] Sending event: tag = /salt/minion/minion_schedule_delete_complete; data = {'complete': True, 'schedule': {'__mine_interval': {'function': 'mine.update', 'minutes': 60, 'jid_include': True, 'maxrunning': 2, 'run_on_start': True, 'return_job': False, 'enabled': True}}, '_stamp': '2023-06-05T03:37:44.314640'} >2023-06-05 05:37:44,315 [salt.transport.ipc:370 ][DEBUG ][4289] Closing IPCMessageClient instance >2023-06-05 05:37:44,315 [salt.utils.schedule:300 ][DEBUG ][4289] Persisting schedule >2023-06-05 05:37:44,317 [salt.utils.event :311 ][DEBUG ][4289] SaltEvent PUB socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pub.ipc >2023-06-05 05:37:44,317 [salt.utils.event :312 ][DEBUG ][4289] SaltEvent PULL socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:44,318 [salt.utils.event :817 ][DEBUG ][4289] Sending event: tag = /salt/minion/minion_schedule_delete_complete; data = {'complete': True, 'schedule': {'__mine_interval': {'function': 'mine.update', 'minutes': 60, 'jid_include': True, 'maxrunning': 2, 'run_on_start': True, 'return_job': False, 'enabled': True}}, '_stamp': '2023-06-05T03:37:44.318097'} >2023-06-05 05:37:44,318 [salt.transport.ipc:370 ][DEBUG ][4289] Closing IPCMessageClient instance >2023-06-05 05:37:44,318 [salt.utils.schedule:300 ][DEBUG ][4289] Persisting schedule >2023-06-05 05:37:44,321 [salt.minion :2629][INFO ][4289] Minion is starting as user 'root' >2023-06-05 05:37:44,322 [salt.minion :3051][DEBUG ][4289] Minion 'master' trying to tune in >2023-06-05 05:37:44,322 [salt.crypt :510 ][DEBUG ][4289] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:44,322 [salt.transport.zeromq:160 ][DEBUG ][4289] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:44,323 [salt.transport.zeromq:1233][DEBUG ][4289] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:44,331 [salt.transport.zeromq:179 ][DEBUG ][4289] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:44,332 [salt.crypt :510 ][DEBUG ][4289] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:44,332 [salt.transport.zeromq:160 ][DEBUG ][4289] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:44,333 [salt.transport.zeromq:1233][DEBUG ][4289] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:44,342 [salt.transport.zeromq:179 ][DEBUG ][4289] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:44,342 [salt.minion :3061][INFO ][4289] Minion is ready to receive requests! >2023-06-05 05:37:44,347 [salt.minion :2673][DEBUG ][4289] Minion of 'localhost' is handling event tag '/salt/minion/minion_schedule_delete_complete' >2023-06-05 05:37:44,348 [salt.minion :2673][DEBUG ][4289] Minion of 'localhost' is handling event tag '/salt/minion/minion_schedule_add_complete' >2023-06-05 05:37:44,348 [salt.minion :2673][DEBUG ][4289] Minion of 'localhost' is handling event tag '/salt/minion/minion_schedule_delete_complete' >2023-06-05 05:37:44,348 [salt.minion :2673][DEBUG ][4289] Minion of 'localhost' is handling event tag '/salt/minion/minion_schedule_delete_complete' >2023-06-05 05:37:45,348 [salt.utils.schedule:1725][DEBUG ][4289] schedule: Job __mine_interval was scheduled with jid_include, adding to cache (jid_include defaults to True) >2023-06-05 05:37:45,348 [salt.utils.schedule:1732][DEBUG ][4289] schedule: Job __mine_interval was scheduled with a max number of 2 >2023-06-05 05:37:45,348 [salt.utils.schedule:1756][INFO ][4289] Running scheduled job: __mine_interval with jid 20230605033745348892 >2023-06-05 05:37:45,352 [salt.utils.process:1219][DEBUG ][4289] Subprocess SignalHandlingProcess-1:2-Schedule-__mine_interval added >2023-06-05 05:37:45,365 [salt.utils.entrypoints:57 ][DEBUG ][4575] Using importlib_metadata to load entry points >2023-06-05 05:37:45,420 [salt.utils.lazy :99 ][DEBUG ][4575] LazyLoaded mine.update >2023-06-05 05:37:45,420 [salt.utils.schedule:785 ][DEBUG ][4575] schedule.handle_func: adding this job to the jobcache with data {'id': 'master', 'fun': 'mine.update', 'fun_args': [], 'schedule': '__mine_interval', 'jid': '20230605033745348892', 'pid': 4575} >2023-06-05 05:37:45,422 [salt.utils.lazy :99 ][DEBUG ][4575] LazyLoaded config.merge >2023-06-05 05:37:45,422 [salt.utils.schedule:925 ][DEBUG ][4575] schedule.handle_func: Removing /var/cache/salt/minion/proc/20230605033745348892 >2023-06-05 05:37:46,349 [salt.utils.process:1230][DEBUG ][4289] Subprocess SignalHandlingProcess-1:2-Schedule-__mine_interval cleaned up >2023-06-05 05:37:47,621 [salt.utils.lazy :99 ][DEBUG ][4289] LazyLoaded glob_match.match >2023-06-05 05:37:47,621 [salt.minion :1701][INFO ][4289] User root Executing command test.ping with jid 20230605033747596548 >2023-06-05 05:37:47,621 [salt.minion :1705][DEBUG ][4289] Command details {'fun': 'test.ping', 'arg': [], 'tgt': '*', 'jid': '20230605033747596548', 'ret': '', 'tgt_type': 'glob', 'user': 'root'} >2023-06-05 05:37:47,625 [salt.utils.process:1219][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033747596548 added >2023-06-05 05:37:47,640 [salt.utils.entrypoints:57 ][DEBUG ][4611] Using importlib_metadata to load entry points >2023-06-05 05:37:47,721 [salt.utils.lazy :99 ][DEBUG ][4611] LazyLoaded jinja.render >2023-06-05 05:37:47,722 [salt.utils.lazy :99 ][DEBUG ][4611] LazyLoaded yaml.render >2023-06-05 05:37:47,726 [salt.minion :1894][INFO ][4611] Starting a new job 20230605033747596548 with PID 4611 >2023-06-05 05:37:47,730 [salt.utils.lazy :103 ][DEBUG ][4611] Could not LazyLoad direct_call.allow_missing_func: 'direct_call.allow_missing_func' is not available. >2023-06-05 05:37:47,732 [salt.utils.lazy :99 ][DEBUG ][4611] LazyLoaded test.ping >2023-06-05 05:37:47,733 [salt.loaded.int.module.test:120 ][DEBUG ][4611] test.ping received for minion 'master' >2023-06-05 05:37:47,733 [salt.minion :894 ][DEBUG ][4611] Minion return retry timer set to 8 seconds (randomized) >2023-06-05 05:37:47,733 [salt.minion :2177][INFO ][4611] Returning information for job: 20230605033747596548 >2023-06-05 05:37:47,734 [salt.crypt :510 ][DEBUG ][4611] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:47,734 [salt.transport.zeromq:160 ][DEBUG ][4611] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:47,735 [salt.transport.zeromq:1233][DEBUG ][4611] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:47,763 [salt.transport.zeromq:179 ][DEBUG ][4611] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:47,764 [salt.minion :2044][DEBUG ][4611] minion return: {'success': True, 'return': True, 'retcode': 0, 'jid': '20230605033747596548', 'fun': 'test.ping', 'fun_args': []} >2023-06-05 05:37:48,347 [salt.utils.process:1230][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033747596548 cleaned up >2023-06-05 05:37:48,550 [salt.loader :896 ][DEBUG ][4624] Grains refresh requested. Refreshing grains. >2023-06-05 05:37:48,550 [salt.config :1933][DEBUG ][4624] Reading configuration from /etc/salt/minion >2023-06-05 05:37:48,606 [salt.config :2096][DEBUG ][4624] Including configuration from '/etc/salt/minion.d/_schedule.conf' >2023-06-05 05:37:48,607 [salt.config :1933][DEBUG ][4624] Reading configuration from /etc/salt/minion.d/_schedule.conf >2023-06-05 05:37:48,663 [salt.loader.lazy :857 ][DEBUG ][4624] Override __utils__: <module 'salt.loaded.int.grains.zfs' from '/usr/lib/python3.6/site-packages/salt/grains/zfs.py'> >2023-06-05 05:37:48,682 [salt.modules.network:2099][DEBUG ][4624] Unable to resolve address fe80::5054:ff:fe12:86c: [Errno 0] Resolver Error 0 (no error) >2023-06-05 05:37:48,781 [salt.modules.network:2135][DEBUG ][4624] Elapsed time getting FQDNs: 0.11013126373291016 seconds >2023-06-05 05:37:48,974 [salt.utils.lazy :99 ][DEBUG ][4624] LazyLoaded zfs.is_supported >2023-06-05 05:37:49,015 [salt.minion :796 ][DEBUG ][4624] Connecting to master. Attempt 1 of 1 >2023-06-05 05:37:49,015 [salt.utils.network:2273][DEBUG ][4624] "localhost" Not an IP address? Assuming it is a hostname. >2023-06-05 05:37:49,016 [salt.minion :238 ][DEBUG ][4624] Master URI: tcp://127.0.0.1:4506 >2023-06-05 05:37:49,039 [salt.crypt :510 ][DEBUG ][4624] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:49,041 [salt.transport.zeromq:429 ][DEBUG ][4624] Generated random reconnect delay between '1000ms' and '11000ms' (6168) >2023-06-05 05:37:49,041 [salt.transport.zeromq:432 ][DEBUG ][4624] Setting zmq_reconnect_ivl to '6168ms' >2023-06-05 05:37:49,041 [salt.transport.zeromq:438 ][DEBUG ][4624] Setting zmq_reconnect_ivl_max to '11000ms' >2023-06-05 05:37:49,042 [salt.transport.zeromq:160 ][DEBUG ][4624] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:49,042 [salt.transport.zeromq:1233][DEBUG ][4624] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:49,042 [salt.crypt :220 ][DEBUG ][4624] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:49,064 [salt.crypt :978 ][DEBUG ][4624] Decrypting the current master AES key >2023-06-05 05:37:49,065 [salt.crypt :212 ][DEBUG ][4624] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:49,065 [salt.crypt :192 ][DEBUG ][4624] salt.crypt._get_key_with_evict: Loading private key >2023-06-05 05:37:49,067 [salt.crypt :904 ][DEBUG ][4624] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:49,076 [salt.crypt :220 ][DEBUG ][4624] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:49,084 [salt.crypt :259 ][DEBUG ][4624] salt.crypt.verify_signature: Loading public key >2023-06-05 05:37:49,084 [salt.crypt :220 ][DEBUG ][4624] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:49,085 [salt.crypt :261 ][DEBUG ][4624] salt.crypt.verify_signature: Verifying signature >2023-06-05 05:37:49,085 [salt.crypt :705 ][DEBUG ][4624] <salt.crypt.AsyncAuth object at 0x7f3c31125128> Got new master aes key. >2023-06-05 05:37:49,085 [salt.transport.zeromq:179 ][DEBUG ][4624] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:49,086 [salt.transport.zeromq:495 ][DEBUG ][4624] Connecting the Minion to the Master publish port, using the URI: tcp://127.0.0.1:4505 >2023-06-05 05:37:49,087 [salt.crypt :212 ][DEBUG ][4624] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:49,087 [salt.crypt :904 ][DEBUG ][4624] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:49,093 [salt.pillar :71 ][DEBUG ][4624] Determining pillar cache >2023-06-05 05:37:49,094 [salt.crypt :510 ][DEBUG ][4624] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:49,094 [salt.transport.zeromq:160 ][DEBUG ][4624] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:49,094 [salt.transport.zeromq:1233][DEBUG ][4624] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:49,214 [salt.crypt :212 ][DEBUG ][4624] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:49,214 [salt.crypt :904 ][DEBUG ][4624] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:49,222 [salt.crypt :259 ][DEBUG ][4624] salt.crypt.verify_signature: Loading public key >2023-06-05 05:37:49,223 [salt.crypt :220 ][DEBUG ][4624] salt.crypt.get_rsa_pub_key: Loading public key >2023-06-05 05:37:49,223 [salt.crypt :261 ][DEBUG ][4624] salt.crypt.verify_signature: Verifying signature >2023-06-05 05:37:49,223 [salt.transport.zeromq:179 ][DEBUG ][4624] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:49,233 [salt.utils.entrypoints:57 ][DEBUG ][4624] Using importlib_metadata to load entry points >2023-06-05 05:37:49,306 [salt.utils.lazy :99 ][DEBUG ][4624] LazyLoaded jinja.render >2023-06-05 05:37:49,307 [salt.utils.lazy :99 ][DEBUG ][4624] LazyLoaded yaml.render >2023-06-05 05:37:49,311 [salt.utils.lazy :99 ][DEBUG ][4624] LazyLoaded test.ping >2023-06-05 05:37:49,313 [salt.utils.lazy :99 ][DEBUG ][4624] LazyLoaded direct_call.execute >2023-06-05 05:37:49,313 [salt.loaded.int.module.test:120 ][DEBUG ][4624] test.ping received for minion 'master' >2023-06-05 05:37:49,314 [salt.crypt :510 ][DEBUG ][4624] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:49,314 [salt.transport.zeromq:160 ][DEBUG ][4624] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:49,314 [salt.transport.zeromq:1233][DEBUG ][4624] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:49,326 [salt.transport.zeromq:179 ][DEBUG ][4624] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:49,329 [salt.utils.lazy :99 ][DEBUG ][4624] LazyLoaded nested.output >2023-06-05 05:37:50,119 [salt.minion :1701][INFO ][4289] User root Executing command test.ping with jid 20230605033750103730 >2023-06-05 05:37:50,119 [salt.minion :1705][DEBUG ][4289] Command details {'fun': 'test.ping', 'arg': [], 'tgt': '*', 'jid': '20230605033750103730', 'ret': '', 'tgt_type': 'glob', 'user': 'root'} >2023-06-05 05:37:50,127 [salt.utils.process:1219][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033750103730 added >2023-06-05 05:37:50,142 [salt.utils.entrypoints:57 ][DEBUG ][4699] Using importlib_metadata to load entry points >2023-06-05 05:37:50,220 [salt.utils.lazy :99 ][DEBUG ][4699] LazyLoaded jinja.render >2023-06-05 05:37:50,221 [salt.utils.lazy :99 ][DEBUG ][4699] LazyLoaded yaml.render >2023-06-05 05:37:50,225 [salt.minion :1894][INFO ][4699] Starting a new job 20230605033750103730 with PID 4699 >2023-06-05 05:37:50,228 [salt.utils.lazy :103 ][DEBUG ][4699] Could not LazyLoad direct_call.allow_missing_func: 'direct_call.allow_missing_func' is not available. >2023-06-05 05:37:50,229 [salt.utils.lazy :99 ][DEBUG ][4699] LazyLoaded test.ping >2023-06-05 05:37:50,231 [salt.loaded.int.module.test:120 ][DEBUG ][4699] test.ping received for minion 'master' >2023-06-05 05:37:50,231 [salt.minion :894 ][DEBUG ][4699] Minion return retry timer set to 5 seconds (randomized) >2023-06-05 05:37:50,231 [salt.minion :2177][INFO ][4699] Returning information for job: 20230605033750103730 >2023-06-05 05:37:50,232 [salt.crypt :510 ][DEBUG ][4699] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:50,232 [salt.transport.zeromq:160 ][DEBUG ][4699] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:50,233 [salt.transport.zeromq:1233][DEBUG ][4699] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:50,244 [salt.transport.zeromq:179 ][DEBUG ][4699] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:50,245 [salt.minion :2044][DEBUG ][4699] minion return: {'success': True, 'return': True, 'retcode': 0, 'jid': '20230605033750103730', 'fun': 'test.ping', 'fun_args': []} >2023-06-05 05:37:50,348 [salt.utils.process:1230][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033750103730 cleaned up >2023-06-05 05:37:51,243 [salt.minion :1701][INFO ][4289] User root Executing command cmd.run with jid 20230605033751228093 >2023-06-05 05:37:51,243 [salt.minion :1705][DEBUG ][4289] Command details {'fun': 'cmd.run', 'arg': ['touch /tmp/salt_touch'], 'tgt': '*', 'jid': '20230605033751228093', 'ret': '', 'tgt_type': 'glob', 'user': 'root'} >2023-06-05 05:37:51,246 [salt.utils.process:1219][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033751228093 added >2023-06-05 05:37:51,261 [salt.utils.entrypoints:57 ][DEBUG ][4729] Using importlib_metadata to load entry points >2023-06-05 05:37:51,338 [salt.utils.lazy :99 ][DEBUG ][4729] LazyLoaded jinja.render >2023-06-05 05:37:51,339 [salt.utils.lazy :99 ][DEBUG ][4729] LazyLoaded yaml.render >2023-06-05 05:37:51,343 [salt.minion :1894][INFO ][4729] Starting a new job 20230605033751228093 with PID 4729 >2023-06-05 05:37:51,348 [salt.utils.lazy :103 ][DEBUG ][4729] Could not LazyLoad direct_call.allow_missing_func: 'direct_call.allow_missing_func' is not available. >2023-06-05 05:37:51,349 [salt.utils.lazy :99 ][DEBUG ][4729] LazyLoaded cmd.run >2023-06-05 05:37:51,352 [salt.utils.lazy :99 ][DEBUG ][4729] LazyLoaded config.get >2023-06-05 05:37:51,354 [salt.loaded.int.module.cmdmod:417 ][INFO ][4729] Executing command 'touch' in directory '/root' >2023-06-05 05:37:51,359 [salt.loaded.int.module.cmdmod:1312][DEBUG ][4729] output: >2023-06-05 05:37:51,360 [salt.minion :894 ][DEBUG ][4729] Minion return retry timer set to 10 seconds (randomized) >2023-06-05 05:37:51,360 [salt.minion :2177][INFO ][4729] Returning information for job: 20230605033751228093 >2023-06-05 05:37:51,361 [salt.crypt :510 ][DEBUG ][4729] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:51,362 [salt.transport.zeromq:160 ][DEBUG ][4729] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:51,362 [salt.transport.zeromq:1233][DEBUG ][4729] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:51,376 [salt.transport.zeromq:179 ][DEBUG ][4729] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:51,377 [salt.minion :2044][DEBUG ][4729] minion return: {'success': True, 'return': '', 'retcode': 0, 'jid': '20230605033751228093', 'fun': 'cmd.run', 'fun_args': ['touch /tmp/salt_touch']} >2023-06-05 05:37:52,347 [salt.utils.process:1230][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033751228093 cleaned up >2023-06-05 05:37:54,007 [salt.minion :1701][INFO ][4289] User root Executing command state.highstate with jid 20230605033753994913 >2023-06-05 05:37:54,007 [salt.minion :1705][DEBUG ][4289] Command details {'fun': 'state.highstate', 'arg': [], 'tgt': '*', 'jid': '20230605033753994913', 'ret': '', 'tgt_type': 'glob', 'user': 'root'} >2023-06-05 05:37:54,010 [salt.utils.process:1219][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033753994913 added >2023-06-05 05:37:54,032 [salt.utils.entrypoints:57 ][DEBUG ][4812] Using importlib_metadata to load entry points >2023-06-05 05:37:54,104 [salt.utils.lazy :99 ][DEBUG ][4812] LazyLoaded jinja.render >2023-06-05 05:37:54,106 [salt.utils.lazy :99 ][DEBUG ][4812] LazyLoaded yaml.render >2023-06-05 05:37:54,109 [salt.minion :1894][INFO ][4812] Starting a new job 20230605033753994913 with PID 4812 >2023-06-05 05:37:54,113 [salt.utils.lazy :103 ][DEBUG ][4812] Could not LazyLoad direct_call.allow_missing_func: 'direct_call.allow_missing_func' is not available. >2023-06-05 05:37:54,115 [salt.utils.lazy :99 ][DEBUG ][4812] LazyLoaded state.highstate >2023-06-05 05:37:54,117 [salt.loader.lazy :857 ][DEBUG ][4812] Override __grains__: <module 'salt.loaded.int.module.grains' from '/usr/lib/python3.6/site-packages/salt/modules/grains.py'> >2023-06-05 05:37:54,117 [salt.utils.lazy :99 ][DEBUG ][4812] LazyLoaded grains.get >2023-06-05 05:37:54,121 [salt.utils.lazy :99 ][DEBUG ][4812] LazyLoaded saltutil.is_running >2023-06-05 05:37:54,123 [salt.utils.lazy :99 ][DEBUG ][4812] LazyLoaded config.get >2023-06-05 05:37:54,133 [salt.crypt :510 ][DEBUG ][4812] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:54,134 [salt.transport.zeromq:160 ][DEBUG ][4812] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:54,134 [salt.transport.zeromq:1233][DEBUG ][4812] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:54,141 [salt.state :750 ][DEBUG ][4812] Gathering pillar data for state run >2023-06-05 05:37:54,142 [salt.pillar :71 ][DEBUG ][4812] Determining pillar cache >2023-06-05 05:37:54,142 [salt.crypt :510 ][DEBUG ][4812] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:54,142 [salt.transport.zeromq:160 ][DEBUG ][4812] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:54,143 [salt.transport.zeromq:1233][DEBUG ][4812] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:54,311 [salt.crypt :212 ][DEBUG ][4812] salt.crypt.get_rsa_key: Loading private key >2023-06-05 05:37:54,312 [salt.crypt :904 ][DEBUG ][4812] Loaded minion key: /etc/salt/pki/minion/minion.pem >2023-06-05 05:37:54,313 [salt.minion :1994][WARNING ][4812] The minion function caused an exception >2023-06-05 05:37:54,314 [salt.utils.event :311 ][DEBUG ][4812] SaltEvent PUB socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pub.ipc >2023-06-05 05:37:54,314 [salt.utils.event :312 ][DEBUG ][4812] SaltEvent PULL socket URI: /var/run/salt/minion/minion_event_fc613b4dfd_pull.ipc >2023-06-05 05:37:54,318 [salt.utils.event :817 ][DEBUG ][4812] Sending event: tag = _salt_error; data = {'message': 'The minion function caused an exception', 'args': ('The minion function caused an exception',), '_stamp': '2023-06-05T03:37:54.318453'} >2023-06-05 05:37:54,323 [salt.minion :2673][DEBUG ][4289] Minion of 'localhost' is handling event tag '_salt_error' >2023-06-05 05:37:54,324 [salt.minion :2891][DEBUG ][4289] Forwarding salt error event tag=_salt_error >2023-06-05 05:37:54,324 [salt.crypt :518 ][DEBUG ][4289] Re-using AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:54,324 [salt.transport.zeromq:160 ][DEBUG ][4289] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:54,325 [salt.transport.zeromq:1233][DEBUG ][4289] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:54,326 [salt.transport.ipc:370 ][DEBUG ][4812] Closing IPCMessageClient instance >2023-06-05 05:37:54,338 [salt.transport.zeromq:179 ][DEBUG ][4289] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:54,339 [salt.minion :894 ][DEBUG ][4812] Minion return retry timer set to 7 seconds (randomized) >2023-06-05 05:37:54,339 [salt.minion :2177][INFO ][4812] Returning information for job: 20230605033753994913 >2023-06-05 05:37:54,340 [salt.crypt :510 ][DEBUG ][4812] Initializing new AsyncAuth for ('/etc/salt/pki/minion', 'master', 'tcp://127.0.0.1:4506') >2023-06-05 05:37:54,340 [salt.transport.zeromq:160 ][DEBUG ][4812] Connecting the Minion to the Master URI (for the return server): tcp://127.0.0.1:4506 >2023-06-05 05:37:54,340 [salt.transport.zeromq:1233][DEBUG ][4812] Trying to connect to: tcp://127.0.0.1:4506 >2023-06-05 05:37:54,354 [salt.transport.zeromq:179 ][DEBUG ][4812] Closing AsyncZeroMQReqChannel instance >2023-06-05 05:37:54,354 [salt.minion :2044][DEBUG ][4812] minion return: {'success': False, 'return': 'The minion function caused an exception: Traceback (most recent call last):\n File "/usr/lib/python3.6/site-packages/salt/minion.py", line 1917, in _thread_return\n function_name, function_args, executors, opts, data\n File "/usr/lib/python3.6/site-packages/salt/minion.py", line 1873, in _execute_job_function\n return_data = self.executors[fname](opts, data, func, args, kwargs)\n File "/usr/lib/python3.6/site-packages/salt/loader/lazy.py", line 149, in __call__\n return self.loader.run(run_func, *args, **kwargs)\n File "/usr/lib/python3.6/site-packages/salt/loader/lazy.py", line 1203, in run\n return self._last_context.run(self._run_as, _func_or_method, *args, **kwargs)\n File "/usr/lib/python3.6/site-packages/contextvars/__init__.py", line 38, in run\n return callable(*args, **kwargs)\n File "/usr/lib/python3.6/site-packages/salt/loader/lazy.py", line 1218, in _run_as\n return _func_or_method(*args, **kwargs)\n File "/usr/lib/python3.6/site-packages/salt/executors/direct_call.py", line 10, in execute\n return func(*args, **kwargs)\n File "/usr/lib/python3.6/site-packages/salt/loader/lazy.py", line 149, in __call__\n return self.loader.run(run_func, *args, **kwargs)\n File "/usr/lib/python3.6/site-packages/salt/loader/lazy.py", line 1203, in run\n return self._last_context.run(self._run_as, _func_or_method, *args, **kwargs)\n File "/usr/lib/python3.6/site-packages/contextvars/__init__.py", line 38, in run\n return callable(*args, **kwargs)\n File "/usr/lib/python3.6/site-packages/salt/loader/lazy.py", line 1218, in _run_as\n return _func_or_method(*args, **kwargs)\n File "/usr/lib/python3.6/site-packages/salt/modules/state.py", line 1100, in highstate\n initial_pillar=_get_initial_pillar(opts),\n File "/usr/lib/python3.6/site-packages/salt/state.py", line 4729, in __init__\n initial_pillar=initial_pillar,\n File "/usr/lib/python3.6/site-packages/salt/state.py", line 755, in __init__\n self.opts["pillar"] = self._gather_pillar()\n File "/usr/lib/python3.6/site-packages/salt/state.py", line 820, in _gather_pillar\n return pillar.compile_pillar()\n File "/usr/lib/python3.6/site-packages/salt/pillar/__init__.py", line 338, in compile_pillar\n dictkey="pillar",\n File "/usr/lib/python3.6/site-packages/salt/utils/asynchronous.py", line 125, in wrap\n raise exc_info[1].with_traceback(exc_info[2])\n File "/usr/lib/python3.6/site-packages/salt/utils/asynchronous.py", line 131, in _target\n result = io_loop.run_sync(lambda: getattr(self.obj, key)(*args, **kwargs))\n File "/usr/lib/python3.6/site-packages/salt/ext/tornado/ioloop.py", line 459, in run_sync\n return future_cell[0].result()\n File "/usr/lib/python3.6/site-packages/salt/ext/tornado/concurrent.py", line 249, in result\n raise_exc_info(self._exc_info)\n File "<string>", line 4, in raise_exc_info\n File "/usr/lib/python3.6/site-packages/salt/ext/tornado/gen.py", line 1070, in run\n yielded = self.gen.send(value)\n File "/usr/lib/python3.6/site-packages/salt/transport/zeromq.py", line 248, in crypted_transfer_decode_dictentry\n aes = key.private_decrypt(ret["key"], RSA.pkcs1_oaep_padding)\n File "/usr/lib64/python3.6/site-packages/M2Crypto/RSA.py", line 82, in private_decrypt\n assert self.check_key(), \'key is not initialised\'\nAssertionError: key is not initialised\n', 'out': 'nested', 'retcode': 1, 'jid': '20230605033753994913', 'fun': 'state.highstate', 'fun_args': []} >2023-06-05 05:37:55,348 [salt.utils.process:1230][DEBUG ][4289] Subprocess ProcessPayload-Job-20230605033753994913 cleaned up
<b>You cannot view the attachment while viewing its details because your browser does not support IFRAMEs. <a href="attachment.cgi?id=867406">View the attachment on a separate page</a>.</b>
Actions:
View
Attachments on
bug 1212025
: 867406