• sshd ignoring environment options in my authorized_keys file

    From Manuel Sopena Ballesteros@21:1/5 to All on Wed Nov 10 11:26:04 2021
    Dear openssh community,

    I need to hardcode some envs linked to user public keys. I am doing this through environment options in authorized_keys file.

    # cat ~/.ssh/authorized_keys
    ssh-rsa AAAAB3N...b97-rzjzh environment="TERM=xterm",environment="MODULEPATH=/opt/cray/pe/perftools/20.12.0.2/modulefiles:/usr/local/Modules/modulefiles:..." ecdsa-sha2-nistp521 AAAAE2VjZHNhL...OHCfwjw== test user key for alpsplat

    For some unknown reason, I can ssh into the remote server but MODULEPATH envs are not part of the session (and the value I set to TERM ignored).

    I am not an expert of ssh and I tried to troubleshoot by enabling the sshd logs but can't find the cause of my issue (logs below).

    # SSHD logs
    debug2: load_server_config: filename /etc/ssh/sshd_config
    debug2: load_server_config: done config len = 503
    debug2: parse_server_config: config /etc/ssh/sshd_config len 503
    debug3: /etc/ssh/sshd_config:32 setting PermitRootLogin yes
    debug3: /etc/ssh/sshd_config:41 setting AuthorizedKeysFile .ssh/authorized_keys debug3: /etc/ssh/sshd_config:84 setting UsePAM yes
    debug3: /etc/ssh/sshd_config:89 setting X11Forwarding yes
    debug3: /etc/ssh/sshd_config:96 setting PermitUserEnvironment yes
    debug3: /etc/ssh/sshd_config:98 setting ClientAliveInterval 250
    debug3: /etc/ssh/sshd_config:99 setting ClientAliveCountMax 3
    debug3: /etc/ssh/sshd_config:111 setting Subsystem sftp /usr/lib/ssh/sftp-server
    debug3: /etc/ssh/sshd_config:114 setting AcceptEnv LANG LC_CTYPE LC_NUMERIC LC_TIME LC_COLLATE LC_MONETARY LC_MESSAGES
    debug3: /etc/ssh/sshd_config:115 setting AcceptEnv LC_PAPER LC_NAME LC_ADDRESS LC_TELEPHONE LC_MEASUREMENT
    debug3: /etc/ssh/sshd_config:116 setting AcceptEnv LC_IDENTIFICATION LC_ALL debug3: /etc/ssh/sshd_config:124 setting UseDNS no
    debug1: sshd version OpenSSH_7.9, OpenSSL 1.1.0i-fips 14 Aug 2018
    debug1: private host key #0: ssh-rsa SHA256:U8oed3itZgztL5Zma3SyEkmtrUFWAGbtaPiJBlFlFXA
    debug1: private host key #1: ecdsa-sha2-nistp256 SHA256:NNeEWTqTChCOcsxUvOsgH0QFOjdWlOZFa84PdismC9s
    debug1: private host key #2: ssh-ed25519 SHA256:vtgSUnxBGQABjFvgaggAuEd3Vqs0+dZ6H5Ne3OI5878
    debug1: rexec_argv[0]='/usr/sbin/sshd'
    debug1: rexec_argv[1]='-ddd'
    debug3: oom_adjust_setup
    debug1: Set /proc/self/oom_score_adj from 1000 to -1000
    debug2: fd 3 setting O_NONBLOCK
    debug1: Bind to port 22 on 0.0.0.0.
    Server listening on 0.0.0.0 port 22.
    debug2: fd 4 setting O_NONBLOCK
    debug3: sock_set_v6only: set socket 4 IPV6_V6ONLY
    debug1: Bind to port 22 on ::.
    Server listening on :: port 22.
    debug3: fd 5 is not O_NONBLOCK
    debug1: Server will not fork when running in debugging mode.
    debug3: send_rexec_state: entering fd = 8 config len 503
    debug3: ssh_msg_send: type 0
    debug3: send_rexec_state: done
    debug1: rexec start in 5 out 5 newsock 5 pipe -1 sock 8
    debug1: inetd sockets after dupping: 3, 3
    Connection from 10.233.72.9 port 39154 on 10.233.72.9 port 22
    debug1: Client protocol version 2.0; client software version OpenSSH_7.9 debug1: match: OpenSSH_7.9 pat OpenSSH* compat 0x04000000
    debug1: Local version string SSH-2.0-OpenSSH_7.9
    debug2: fd 3 setting O_NONBLOCK
    debug3: ssh_sandbox_init: preparing seccomp filter sandbox
    debug2: Network child is on pid 93
    debug3: preauth child monitor started
    debug3: privsep user:group 481:482 [preauth]
    debug1: permanently_set_uid: 481/482 [preauth]
    debug3: ssh_sandbox_child: setting PR_SET_NO_NEW_PRIVS [preauth]
    debug3: ssh_sandbox_child: attaching seccomp filter program [preauth]
    debug1: list_hostkey_types: rsa-sha2-512,rsa-sha2-256,ssh-rsa,ecdsa-sha2-nistp256,ssh-ed25519 [preauth]
    debug3: send packet: type 20 [preauth]
    debug1: SSH2_MSG_KEXINIT sent [preauth]
    debug3: receive packet: type 20 [preauth]
    debug1: SSH2_MSG_KEXINIT received [preauth]
    debug2: local server KEXINIT proposal [preauth]
    debug2: KEX algorithms: curve25519-sha256,curve25519-sha256@libssh.org,ecdh-sha2-nistp256,ecdh-sha2-nistp384,ecdh-sha2-nistp521,diffie-hellman-group-exchange-sha256,diffie-hellman-group16-sha512,diffie-hellman-group18-sha512,diffie-hellman-group14-sha256,
    diffie-hellman-group14-sha1 [preauth]
    debug2: host key algorithms: rsa-sha2-512,rsa-sha2-256,ssh-rsa,ecdsa-sha2-nistp256,ssh-ed25519 [preauth]
    debug2: ciphers ctos: chacha20-poly1305@openssh.com,aes128-ctr,aes192-ctr,aes256-ctr,aes128-gcm@openssh.com,aes256-gcm@openssh.com [preauth]
    debug2: ciphers stoc: chacha20-poly1305@openssh.com,aes128-ctr,aes192-ctr,aes256-ctr,aes128-gcm@openssh.com,aes256-gcm@openssh.com [preauth]
    debug2: MACs ctos: umac-64-etm@openssh.com,umac-128-etm@openssh.com,hmac-sha2-256-etm@openssh.com,hmac-sha2-512-etm@openssh.com,hmac-sha1-etm@openssh.com,umac-64@openssh.com,umac-128@openssh.com,hmac-sha2-256,hmac-sha2-512,hmac-sha1 [preauth]
    debug2: MACs stoc: umac-64-etm@openssh.com,umac-128-etm@openssh.com,hmac-sha2-256-etm@openssh.com,hmac-sha2-512-etm@openssh.com,hmac-sha1-etm@openssh.com,umac-64@openssh.com,umac-128@openssh.com,hmac-sha2-256,hmac-sha2-512,hmac-sha1 [preauth]
    debug2: compression ctos: none,zlib@openssh.com [preauth]
    debug2: compression stoc: none,zlib@openssh.com [preauth]
    debug2: languages ctos: [preauth]
    debug2: languages stoc: [preauth]
    debug2: first_kex_follows 0 [preauth]
    debug2: reserved 0 [preauth]
    debug2: peer client KEXINIT proposal [preauth]
    debug2: KEX algorithms: curve25519-sha256,curve25519-sha256@libssh.org,ecdh-sha2-nistp256,ecdh-sha2-nistp384,ecdh-sha2-nistp521,diffie-hellman-group-exchange-sha256,diffie-hellman-group16-sha512,diffie-hellman-group18-sha512,diffie-hellman-group14-sha256,
    diffie-hellman-group14-sha1,ext-info-c [preauth]
    debug2: host key algorithms: ecdsa-sha2-nistp256-cert-v01@openssh.com,ecdsa-sha2-nistp384-cert-v01@openssh.com,ecdsa-sha2-nistp521-cert-v01@openssh.com,ssh-ed25519-cert-v01@openssh.com,rsa-sha2-512-cert-v01@openssh.com,rsa-sha2-256-cert-v01@openssh.com,
    ssh-rsa-cert-v01@openssh.com,ecdsa-sha2-nistp256,ecdsa-sha2-nistp384,ecdsa-sha2-nistp521,ssh-ed25519,rsa-sha2-512,rsa-sha2-256,ssh-rsa [preauth]
    debug2: ciphers ctos: chacha20-poly1305@openssh.com,aes128-ctr,aes192-ctr,aes256-ctr,aes128-gcm@openssh.com,aes256-gcm@openssh.com [preauth]
    debug2: ciphers stoc: chacha20-poly1305@openssh.com,aes128-ctr,aes192-ctr,aes256-ctr,aes128-gcm@openssh.com,aes256-gcm@openssh.com [preauth]
    debug2: MACs ctos: umac-64-etm@openssh.com,umac-128-etm@openssh.com,hmac-sha2-256-etm@openssh.com,hmac-sha2-512-etm@openssh.com,hmac-sha1-etm@openssh.com,umac-64@openssh.com,umac-128@openssh.com,hmac-sha2-256,hmac-sha2-512,hmac-sha1 [preauth]
    debug2: MACs stoc: umac-64-etm@openssh.com,umac-128-etm@openssh.com,hmac-sha2-256-etm@openssh.com,hmac-sha2-512-etm@openssh.com,hmac-sha1-etm@openssh.com,umac-64@openssh.com,umac-128@openssh.com,hmac-sha2-256,hmac-sha2-512,hmac-sha1 [preauth]
    debug2: compression ctos: none,zlib@openssh.com,zlib [preauth]
    debug2: compression stoc: none,zlib@openssh.com,zlib [preauth]
    debug2: languages ctos: [preauth]
    debug2: languages stoc: [preauth]
    debug2: first_kex_follows 0 [preauth]
    debug2: reserved 0 [preauth]
    debug1: kex: algorithm: curve25519-sha256 [preauth]
    debug1: kex: host key algorithm: ecdsa-sha2-nistp256 [preauth]
    debug1: kex: client->server cipher: chacha20-poly1305@openssh.com MAC: <implicit> compression: none [preauth]
    debug1: kex: server->client cipher: chacha20-poly1305@openssh.com MAC: <implicit> compression: none [preauth]
    debug1: kex: curve25519-sha256 need=64 dh_need=64 [preauth]
    debug3: mm_request_send entering: type 120 [preauth]
    debug3: mm_request_receive_expect entering: type 121 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 120
    debug3: mm_request_send entering: type 121
    debug1: kex: curve25519-sha256 need=64 dh_need=64 [preauth]
    debug3: mm_request_send entering: type 120 [preauth]
    debug3: mm_request_receive_expect entering: type 121 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 120
    debug3: mm_request_send entering: type 121
    debug1: expecting SSH2_MSG_KEX_ECDH_INIT [preauth]
    debug3: receive packet: type 30 [preauth]
    debug3: mm_sshkey_sign entering [preauth]
    debug3: mm_request_send entering: type 6 [preauth]
    debug3: mm_sshkey_sign: waiting for MONITOR_ANS_SIGN [preauth]
    debug3: mm_request_receive_expect entering: type 7 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 6
    debug3: mm_answer_sign
    debug3: mm_answer_sign: hostkey proof signature 0x55e2a446d310(100)
    debug3: mm_request_send entering: type 7
    debug2: monitor_read: 6 used once, disabling now
    debug3: send packet: type 31 [preauth]
    debug3: send packet: type 21 [preauth]
    debug2: set_newkeys: mode 1 [preauth]
    debug1: rekey after 134217728 blocks [preauth]
    debug1: SSH2_MSG_NEWKEYS sent [preauth]
    debug1: expecting SSH2_MSG_NEWKEYS [preauth]
    debug3: send packet: type 7 [preauth]
    debug3: receive packet: type 21 [preauth]
    debug1: SSH2_MSG_NEWKEYS received [preauth]
    debug2: set_newkeys: mode 0 [preauth]
    debug1: rekey after 134217728 blocks [preauth]
    debug1: KEX done [preauth]
    debug3: receive packet: type 5 [preauth]
    debug3: send packet: type 6 [preauth]
    debug3: receive packet: type 50 [preauth]
    debug1: userauth-request for user root service ssh-connection method none [preauth]
    debug1: attempt 0 failures 0 [preauth]
    debug3: mm_getpwnamallow entering [preauth]
    debug3: mm_request_send entering: type 8 [preauth]
    debug3: mm_getpwnamallow: waiting for MONITOR_ANS_PWNAM [preauth]
    debug3: mm_request_receive_expect entering: type 9 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 8
    debug3: mm_answer_pwnamallow
    debug2: parse_server_config: config reprocess config len 503
    debug3: mm_answer_pwnamallow: sending MONITOR_ANS_PWNAM: 1
    debug3: mm_request_send entering: type 9
    debug2: monitor_read: 8 used once, disabling now
    debug2: input_userauth_request: setting up authctxt for root [preauth]
    debug3: mm_start_pam entering [preauth]
    debug3: mm_request_send entering: type 100 [preauth]
    debug3: mm_inform_authserv entering [preauth]
    debug3: mm_request_send entering: type 4 [preauth]
    debug2: input_userauth_request: try method none [preauth]
    debug3: user_specific_delay: user specific delay 0.000ms [preauth]
    debug3: ensure_minimum_time_since: elapsed 0.953ms, delaying 6.748ms (requested 7.700ms) [preauth]
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 100
    debug1: PAM: initializing for "root"
    debug1: PAM: setting PAM_RHOST to "10.233.72.9"
    debug1: PAM: setting PAM_TTY to "ssh"
    debug2: monitor_read: 100 used once, disabling now
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 4
    debug3: mm_answer_authserv: service=ssh-connection, style=
    debug2: monitor_read: 4 used once, disabling now
    debug3: userauth_finish: failure partial=0 next methods="publickey,password,keyboard-interactive" [preauth]
    debug3: send packet: type 51 [preauth]
    debug3: receive packet: type 50 [preauth]
    debug1: userauth-request for user root service ssh-connection method publickey [preauth]
    debug1: attempt 1 failures 0 [preauth]
    debug2: input_userauth_request: try method publickey [preauth]
    debug3: userauth_pubkey: have rsa-sha2-512 signature for RSA SHA256:tvozeMsovr6N5MtNGIXh8g+RgccBCK6pximmqDNSlbQ [preauth]
    debug3: mm_key_allowed entering [preauth]
    debug3: mm_request_send entering: type 22 [preauth]
    debug3: mm_key_allowed: waiting for MONITOR_ANS_KEYALLOWED [preauth]
    debug3: mm_request_receive_expect entering: type 23 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 22
    debug3: mm_answer_keyallowed entering
    debug3: mm_answer_keyallowed: key_from_blob: 0x55e2a4473a90
    debug1: temporarily_use_uid: 0/0 (e=0/0)
    debug1: trying public key file /root/.ssh/authorized_keys
    debug1: fd 4 clearing O_NONBLOCK
    debug1: /root/.ssh/authorized_keys:1: matching key found: RSA SHA256:tvozeMsovr6N5MtNGIXh8g+RgccBCK6pximmqDNSlbQ
    debug1: /root/.ssh/authorized_keys:1: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding
    Accepted key RSA SHA256:tvozeMsovr6N5MtNGIXh8g+RgccBCK6pximmqDNSlbQ found at /root/.ssh/authorized_keys:1
    debug1: restore_uid: 0/0
    debug3: mm_answer_keyallowed: publickey authentication: RSA key is allowed debug3: mm_request_send entering: type 23
    debug3: mm_sshkey_verify entering [preauth]
    debug3: mm_request_send entering: type 24 [preauth]
    debug3: mm_sshkey_verify: waiting for MONITOR_ANS_KEYVERIFY [preauth]
    debug3: mm_request_receive_expect entering: type 25 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug3: mm_request_receive entering
    debug3: monitor_read: checking request 24
    debug3: mm_answer_keyverify: publickey 0x55e2a4474570 signature verified debug1: auth_activate_options: setting new authentication options
    debug3: mm_request_send entering: type 25
    debug3: mm_request_receive_expect entering: type 102
    debug3: mm_request_receive entering
    debug1: do_pam_account: called
    debug2: do_pam_account: auth information in SSH_AUTH_INFO_0
    debug3: PAM: do_pam_account pam_acct_mgmt = 0 (Success)
    debug3: mm_request_send entering: type 103
    Accepted publickey for root from 10.233.72.9 port 39154 ssh2: RSA SHA256:tvozeMsovr6N5MtNGIXh8g+RgccBCK6pximmqDNSlbQ
    debug1: monitor_child_preauth: root has been authenticated by privileged process
    debug3: mm_get_keystate: Waiting for new keys
    debug3: mm_request_receive_expect entering: type 26
    debug3: mm_request_receive entering
    debug3: mm_get_keystate: GOT new keys
    debug3: mm_request_receive_expect entering: type 122
    debug3: mm_request_receive entering
    debug3: mm_request_send entering: type 123
    debug1: auth_activate_options: setting new authentication options [preauth] debug2: userauth_pubkey: authenticated 1 pkalg rsa-sha2-512 [preauth]
    debug3: user_specific_delay: user specific delay 0.000ms [preauth]
    debug3: ensure_minimum_time_since: elapsed 0.657ms, delaying 7.043ms (requested 7.700ms) [preauth]
    debug3: mm_do_pam_account entering [preauth]
    debug3: mm_request_send entering: type 102 [preauth]
    debug3: mm_request_receive_expect entering: type 103 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug3: mm_do_pam_account returning 1 [preauth]
    debug3: send packet: type 52 [preauth]
    debug3: mm_request_send entering: type 26 [preauth]
    debug3: mm_send_keystate: Finished sending state [preauth]
    debug3: mm_request_send entering: type 122 [preauth]
    debug3: mm_request_receive_expect entering: type 123 [preauth]
    debug3: mm_request_receive entering [preauth]
    debug1: monitor_read_log: child log fd closed
    debug3: ssh_sandbox_parent_finish: finished
    debug1: audit_event: unhandled event 2
    debug1: PAM: establishing credentials
    debug3: PAM: opening session
    debug2: do_pam_session: auth information in SSH_AUTH_INFO_0
    debug3: monitor_apply_keystate: packet_set_state
    debug2: set_newkeys: mode 0
    debug1: rekey after 134217728 blocks
    debug2: set_newkeys: mode 1
    debug1: rekey after 134217728 blocks
    debug1: ssh_packet_set_postauth: called
    debug3: ssh_packet_set_state: done
    debug3: notify_hostkeys: key 0: ssh-rsa SHA256:U8oed3itZgztL5Zma3SyEkmtrUFWAGbtaPiJBlFlFXA
    debug3: notify_hostkeys: key 1: ecdsa-sha2-nistp256 SHA256:NNeEWTqTChCOcsxUvOsgH0QFOjdWlOZFa84PdismC9s
    debug3: notify_hostkeys: key 2: ssh-ed25519 SHA256:vtgSUnxBGQABjFvgaggAuEd3Vqs0+dZ6H5Ne3OI5878
    debug3: notify_hostkeys: sent 3 hostkeys
    debug3: send packet: type 80
    debug1: active: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding
    debug3: sending debug message: /root/.ssh/authorized_keys:1: key options: agent-forwarding port-forwarding pty user-rc x11-forwarding
    debug3: send packet: type 4
    debug1: Entering interactive session for SSH2.
    debug2: fd 4 setting O_NONBLOCK
    debug2: fd 6 setting O_NONBLOCK
    debug1: server_init_dispatch
    debug3: receive packet: type 90
    debug1: server_input_channel_open: ctype session rchan 0 win 1048576 max 16384 debug1: input_session_request
    debug1: channel 0: new [server-session]
    debug2: session_new: allocate (allocated 0 max 10)
    debug3: session_unused: session id 0 unused
    debug1: session_new: session 0
    debug1: session_open: channel 0
    debug1: session_open: session 0: link with channel 0
    debug1: server_input_channel_open: confirm session
    debug3: send packet: type 91
    debug3: receive packet: type 80
    debug1: server_input_global_request: rtype no-more-sessions@openssh.com want_reply 0
    debug3: receive packet: type 98
    debug1: server_input_channel_req: channel 0 request pty-req reply 1
    debug1: session_by_channel: session 0 channel 0
    debug1: session_input_channel_req: session 0 req pty-req
    debug1: Allocating pty.
    debug1: session_pty_req: session 0 alloc /dev/pts/1
    debug1: SELinux support disabled
    debug3: send packet: type 99
    debug3: receive packet: type 98
    debug1: server_input_channel_req: channel 0 request shell reply 1
    debug1: session_by_channel: session 0 channel 0
    debug1: session_input_channel_req: session 0 req shell
    Starting session: shell on pts/1 for root from 10.233.72.9 port 39154 id 0 debug2: fd 3 setting TCP_NODELAY
    debug3: ssh_packet_set_tos: set IP_TOS 0x10
    debug2: channel 0: rfd 9 isatty
    debug2: fd 9 setting O_NONBLOCK
    debug3: fd 7 is O_NONBLOCK
    debug3: send packet: type 99
    debug1: Setting controlling tty using TIOCSCTTY.


    Could someone please help to understand why the environment options linked to the public key (second from the top) if the authorized_keys file are ignored?

    thank you very much

    --- SoupGate-Win32 v1.05
    * Origin: fsxNet Usenet Gateway (21:1/5)