Out of the box, Ansible Fails With Invalid Password

7abc39bd7efb38 commented 1 year ago

This is running on Fedora Linux 38 (Workstation Edition). Ansible Docker container eventually shuts down. No working Raspberry Pi image is created.

2023-07-07 22:44:24 pi-emulator_1 2023-07-07 22:44:32 pi-emulator_1 2023-07-07 22:44:32 pi-emulator_1 2023-07-07 22:44:32 pi-emulator_1 2023-07-07 22:44:28 ansible-playbook_1 2023-07-07 22:44:28 ansible-playbook_1 2023-07-07 22:44:28 ansible-playbook_1 2023-07-07 22:44:28 ansible-playbook_1 2023-07-07 22:44:29 ansible-playbook_1 2023-07-07 22:44:29 ansible-playbook_1 2023-07-07 22:44:29 ansible-playbook_1 2023-07-07 22:44:43 ansible-playbook_1 2023-07-07 22:44:43 ansible-playbook_1 2023-07-07 22:44:43 ansible-playbook_1 2023-07-07 22:45:58 ansible-playbook_1 2023-07-07 22:45:58 ansible-playbook_1 2023-07-07 22:45:58 ansible-playbook_1 2023-07-07 22:46:48 ansible-playbook_1 2023-07-07 22:46:48 ansible-playbook_1 2023-07-07 22:46:48 ansible-playbook_1 2023-07-07 22:46:48 ansible-playbook_1 2023-07-07 22:46:48 ansible-playbook_1 2023-07-07 22:47:06 ansible-playbook_1 2023-07-07 22:47:06 ansible-playbook_1 2023-07-07 22:47:06 ansible-playbook_1 2023-07-07 22:47:06 ansible-playbook_1 2023-07-07 22:44:47 pi-emulator_1 2023-07-07 22:44:47 pi-emulator_1 2023-07-07 22:44:47 pi-emulator_1 2023-07-07 22:44:55 pi-emulator_1 2023-07-07 22:44:55 pi-emulator_1 2023-07-07 22:44:55 pi-emulator_1 2023-07-07 22:44:55 pi-emulator_1 2023-07-07 22:44:55 pi-emulator_1 2023-07-07 22:44:55 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:56 pi-emulator_1 2023-07-07 22:44:57 pi-emulator_1 2023-07-07 22:44:57 pi-emulator_1 2023-07-07 22:44:57 pi-emulator_1 2023-07-07 22:44:57 pi-emulator_1 2023-07-07 22:44:57 pi-emulator_1 2023-07-07 22:44:57 pi-emulator_1 2023-07-07 22:44:58 pi-emulator_1 2023-07-07 22:44:59 pi-emulator_1 2023-07-07 22:44:59 pi-emulator_1 2023-07-07 22:44:59 pi-emulator_1 2023-07-07 22:44:59 pi-emulator_1 2023-07-07 22:45:00 pi-emulator_1 2023-07-07 22:45:00 pi-emulator_1 2023-07-07 22:45:00 pi-emulator_1 2023-07-07 22:45:01 pi-emulator_1 2023-07-07 22:45:01 pi-emulator_1 2023-07-07 22:45:01 pi-emulator_1 2023-07-07 22:45:01 pi-emulator_1 2023-07-07 22:45:02 pi-emulator_1 2023-07-07 22:45:02 pi-emulator_1 2023-07-07 22:45:02 pi-emulator_1 2023-07-07 22:45:02 pi-emulator_1 2023-07-07 22:45:02 pi-emulator_1 2023-07-07 22:45:02 pi-emulator_1 2023-07-07 22:45:03 pi-emulator_1 2023-07-07 22:45:03 pi-emulator_1 2023-07-07 22:45:03 pi-emulator_1 2023-07-07 22:45:04 pi-emulator_1 2023-07-07 22:45:04 pi-emulator_1 2023-07-07 22:45:04 pi-emulator_1 2023-07-07 22:45:04 pi-emulator_1 2023-07-07 22:45:04 pi-emulator_1 2023-07-07 22:45:05 pi-emulator_1 2023-07-07 22:45:05 pi-emulator_1 2023-07-07 22:45:05 pi-emulator_1 2023-07-07 22:45:05 pi-emulator_1 2023-07-07 22:45:06 pi-emulator_1 2023-07-07 22:45:06 pi-emulator_1 2023-07-07 22:45:07 pi-emulator_1 2023-07-07 22:45:08 pi-emulator_1 2023-07-07 22:45:10 pi-emulator_1 2023-07-07 22:45:10 pi-emulator_1 2023-07-07 22:45:10 pi-emulator_1 2023-07-07 22:45:11 pi-emulator_1 [ OK ] Found device /dev/ttyAMA0. 2023-07-07 22:45:17 pi-emulator_1 2023-07-07 22:45:17 pi-emulator_1 2023-07-07 22:45:18 pi-emulator_1 2023-07-07 22:45:19 pi-emulator_1 2023-07-07 22:45:19 pi-emulator_1 2023-07-07 22:45:20 pi-emulator_1 2023-07-07 22:45:20 pi-emulator_1 2023-07-07 22:45:20 pi-emulator_1 2023-07-07 22:45:20 pi-emulator_1 2023-07-07 22:45:20 pi-emulator_1 2023-07-07 22:45:21 pi-emulator_1 2023-07-07 22:45:21 pi-emulator_1 2023-07-07 22:45:21 pi-emulator_1 2023-07-07 22:45:21 pi-emulator_1 2023-07-07 22:45:21 pi-emulator_1 2023-07-07 22:45:21 pi-emulator_1 2023-07-07 22:45:24 pi-emulator_1 2023-07-07 22:45:24 pi-emulator_1 2023-07-07 22:45:24 pi-emulator_1 2023-07-07 22:45:25 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:28 pi-emulator_1 2023-07-07 22:45:29 pi-emulator_1 2023-07-07 22:45:30 pi-emulator_1 2023-07-07 22:45:30 pi-emulator_1 2023-07-07 22:45:30 pi-emulator_1 2023-07-07 22:45:30 pi-emulator_1 2023-07-07 22:45:31 pi-emulator_1 2023-07-07 22:45:31 pi-emulator_1 2023-07-07 22:45:32 pi-emulator_1 2023-07-07 22:45:33 pi-emulator_1 2023-07-07 22:45:34 pi-emulator_1 2023-07-07 22:45:35 pi-emulator_1 2023-07-07 22:45:36 pi-emulator_1 2023-07-07 22:45:37 pi-emulator_1 2023-07-07 22:45:37 pi-emulator_1 2023-07-07 22:45:38 pi-emulator_1 2023-07-07 22:45:39 pi-emulator_1 2023-07-07 22:45:39 pi-emulator_1 2023-07-07 22:45:40 pi-emulator_1 2023-07-07 22:45:40 pi-emulator_1 2023-07-07 22:45:42 pi-emulator_1 2023-07-07 22:45:42 pi-emulator_1 2023-07-07 22:45:44 pi-emulator_1 [ OK ] Started Authorization Manager. 2023-07-07 22:45:44 pi-emulator_1 2023-07-07 22:45:44 pi-emulator_1 2023-07-07 22:45:44 pi-emulator_1 2023-07-07 22:45:44 pi-emulator_1 2023-07-07 22:45:44 pi-emulator_1 2023-07-07 22:45:45 pi-emulator_1 2023-07-07 22:45:46 pi-emulator_1 2023-07-07 22:45:46 pi-emulator_1 2023-07-07 22:45:47 pi-emulator_1 2023-07-07 22:45:47 pi-emulator_1 2023-07-07 22:45:47 pi-emulator_1 2023-07-07 22:45:47 pi-emulator_1 2023-07-07 22:45:48 pi-emulator_1 2023-07-07 22:45:48 pi-emulator_1 2023-07-07 22:45:48 pi-emulator_1 2023-07-07 22:45:48 pi-emulator_1 2023-07-07 22:45:56 pi-emulator_1 2023-07-07 22:45:56 pi-emulator_1 2023-07-07 22:45:56 pi-emulator_1 2023-07-07 22:45:56 pi-emulator_1 2023-07-07 22:45:56 pi-emulator_1 2023-07-07 22:46:02 pi-emulator_1 2023-07-07 22:46:02 pi-emulator_1 2023-07-07 22:46:02 pi-emulator_1 2023-07-07 22:46:02 pi-emulator_1 2023-07-07 22:46:02 pi-emulator_1 2023-07-07 22:46:02 pi-emulator_1 2023-07-07 22:46:03 pi-emulator_1 2023-07-07 22:46:03 pi-emulator_1 2023-07-07 22:46:13 pi-emulator_1 2023-07-07 22:46:13 pi-emulator_1 2023-07-07 22:46:13 pi-emulator_1 2023-07-07 22:46:13 pi-emulator_1 2023-07-07 22:46:24 pi-emulator_1 2023-07-07 22:46:37 pi-emulator_1 2023-07-07 22:46:37 pi-emulator_1 2023-07-07 22:46:37 pi-emulator_1 2023-07-07 22:46:38 pi-emulator_1 2023-07-07 22:46:38 pi-emulator_1 2023-07-07 22:46:39 pi-emulator_1 2023-07-07 22:46:39 pi-emulator_1 2023-07-07 22:46:40 pi-emulator_1 2023-07-07 22:46:45 pi-emulator_1 2023-07-07 22:46:45 pi-emulator_1 2023-07-07 22:54:30 ansible-playbook_1 2023-07-07 22:54:30 ansible-playbook_1 2023-07-07 22:54:30 ansible-playbook_1 2023-07-07 22:54:30 ansible-playbook_1 2023-07-07 22:54:30 ansible-playbook_1 1969-12-31 18:00:00 ansible-playbook_1 | [INFO] No 'distro.qcow2' provided in volume, providing default one ... | [INFO] No 'kernel8.img' provided in volume, providing default one ... | [INFO] No 'pi3.dtb' provided in volume, providing default one ... | [INFO] Starting the emulator ... | | PLAY [raspberries] ***** | | TASK [Wait till RPI enters the running phase] ** | [WARNING]: Unhandled error in Python interpreter discovery for host | 172.16.238.10: Failed to connect to the host via ssh: ssh: connect to host | 172.16.238.10 port 2222: Connection refused | [WARNING]: Unhandled error in Python interpreter discovery for host | 172.16.238.10: Failed to connect to the host via ssh: Connection timed out | during banner exchange | [WARNING]: Unhandled error in Python interpreter discovery for host | 172.16.238.10: Failed to connect to the host via ssh: | ssh_exchange_identification: read: Connection reset by peer | [WARNING]: Unhandled error in Python interpreter discovery for host | 172.16.238.10: Invalid/incorrect password: Warning: Permanently added | '[172.16.238.10]:2222' (ECDSA) to the list of known hosts. Please note that | SSH may not work until a valid user has been set up. See | http://rptl.io/newuser for details. Permission denied, please try again. | [WARNING]: Unhandled error in Python interpreter discovery for host | 172.16.238.10: Invalid/incorrect password: Please note that SSH may not work | until a valid user has been set up. See http://rptl.io/newuser for details. | Permission denied, please try again. | | Welcome to Debian GNU/Linux 11 (bullseye)! | | [ OK ] Created slice system-modprobe.slice. | [ OK ] Created slice system-serial\x2dgetty.slice. | [ OK ] Created slice system-systemd\x2dfsck.slice. | [ OK ] Created slice User and Session Slice. | [ OK ] Started Dispatch Password …ts to Console Directory Watch. | [ OK ] Started Forward Password R…uests to Wall Directory Watch. | [ OK ] Set up automount Arbitrary…s File System Automount Point. | [ OK ] Reached target Local Encrypted Volumes. | [ OK ] Reached target Paths. | [ OK ] Reached target Slices. | [ OK ] Reached target Swap. | [ OK ] Listening on Syslog Socket. | [ OK ] Listening on fsck to fsckd communication Socket. | [ OK ] Listening on initctl Compatibility Named Pipe. | [ OK ] Listening on Journal Audit Socket. | [ OK ] Listening on Journal Socket (/dev/log). | [ OK ] Listening on Journal Socket. | [ OK ] Listening on udev Control Socket. | [ OK ] Listening on udev Kernel Socket. | Mounting POSIX Message Queue File System... | Mounting RPC Pipe File System... | Mounting Kernel Debug File System... | Mounting Kernel Trace File System... | Starting Restore / save the current clock... | Starting Set the console keyboard layout... | Starting Create list of st…odes for the current kernel... | Starting Load Kernel Module configfs... | Starting Load Kernel Module drm... | Starting Load Kernel Module fuse... | Starting Journal Service... | Starting Load Kernel Modules... | Starting Remount Root and Kernel File Systems... | Starting Wait Until Kernel Time Synchronized... | Starting Coldplug All udev Devices... | [ OK ] Mounted POSIX Message Queue File System. | [ OK ] Mounted RPC Pipe File System. | [ OK ] Mounted Kernel Debug File System. | [ OK ] Mounted Kernel Trace File System. | [ OK ] Finished Restore / save the current clock. | [ OK ] Finished Create list of st… nodes for the current kernel. | [ OK ] Finished Load Kernel Module configfs. | [ OK ] Finished Load Kernel Module drm. | [ OK ] Finished Load Kernel Module fuse. | [ OK ] Finished Load Kernel Modules. | Mounting FUSE Control File System... | Mounting Kernel Configuration File System... | Starting Apply Kernel Variables... | [ OK ] Finished Remount Root and Kernel File Systems. | Starting Load/Save Random Seed... | Starting Create System Users... | [ OK ] Mounted FUSE Control File System. | [ OK ] Mounted Kernel Configuration File System. | [ OK ] Finished Apply Kernel Variables. | [ OK ] Finished Load/Save Random Seed. | [ OK ] Started Journal Service. | Starting Flush Journal to Persistent Storage... | [ OK ] Finished Create System Users. | Starting Create Static Device Nodes in /dev... | [ OK ] Finished Set the console keyboard layout. | [ OK ] Finished Create Static Device Nodes in /dev. | [ OK ] Reached target Local File Systems (Pre). | Starting Rule-based Manage…for Device Events and Files... | [ OK ] Finished Flush Journal to Persistent Storage. | [ OK ] Finished Coldplug All udev Devices. | Starting Helper to synchronize boot up for ifupdown... | [ OK ] Finished Helper to synchronize boot up for ifupdown. | [ OK ] Started Rule-based Manager for Device Events and Files. | [ OK ] Found device /dev/mmcblk0p1. | Starting File System Check on /dev/mmcblk0p1... | [ OK ] Started File System Check Daemon to report status. | [ OK ] Finished File System Check on /dev/mmcblk0p1. | Mounting /boot... | [ OK ] Mounted /boot. | [ OK ] Reached target Local File Systems. | Starting Set console font and keymap... | Starting Raise network interfaces... | Starting Preprocess NFS configuration... | Starting Create Volatile Files and Directories... | [ OK ] Finished Preprocess NFS configuration. | [ OK ] Finished Set console font and keymap. | [ OK ] Reached target NFS client services. | [ OK ] Reached target Remote File Systems (Pre). | [ OK ] Reached target Remote File Systems. | [ OK ] Finished Create Volatile Files and Directories. | Starting Network Time Synchronization... | Starting Update UTMP about System Boot/Shutdown... | [ OK ] Finished Update UTMP about System Boot/Shutdown. | [ OK ] Started Network Time Synchronization. | [ OK ] Reached target System Initialization. | [ OK ] Started Daily Cleanup of Temporary Directories. | [ OK ] Reached target System Time Set. | [ OK ] Listening on Avahi mDNS/DNS-SD Stack Activation Socket. | [ OK ] Listening on D-Bus System Message Bus Socket. | [ OK ] Listening on triggerhappy.socket. | [ OK ] Reached target Sockets. | [ OK ] Reached target Basic System. | Starting Avahi mDNS/DNS-SD Stack... | [ OK ] Started Regular background program processing daemon. | [ OK ] Started D-Bus System Message Bus. | Starting dphys-swapfile - …unt, and delete a swap file... | Starting Remove Stale Onli…t4 Metadata Check Snapshots... | Starting Configure Bluetooth Modems connected by UART... | Starting Authorization Manager... | Starting DHCP Client Daemon... | Starting LSB: Switch to on…nless shift key is pressed)... | Starting LSB: rng-tools (Debian variant)... | Starting Check for Raspberry Pi EEPROM updates... | Starting System Logging Service... | Starting Turn on SSH if /boot/ssh is present... | Starting User Login Management... | Starting triggerhappy global hotkey daemon... | Starting Disk Manager... | Starting WPA supplicant... | [ OK ] Started System Logging Service. | [ OK ] Started triggerhappy global hotkey daemon. | [ OK ] Finished Raise network interfaces. | [ OK ] Finished Remove Stale Onli…ext4 Metadata Check Snapshots. | [FAILED] Failed to start Check for Raspberry Pi EEPROM updates. | See 'systemctl status rpi-eeprom-update.service' for details. | | [ OK ] Started WPA supplicant. | [ OK ] Started Avahi mDNS/DNS-SD Stack. | [ OK ] Reached target Network. | [ OK ] Listening on Load/Save RF …itch Status /dev/rfkill Watch. | Starting Modem Manager... | Starting /etc/rc.local Compatibility... | Starting Permit User Sessions... | [ OK ] Finished dphys-swapfile - …mount, and delete a swap file. | [ OK ] Started LSB: Switch to ond…(unless shift key is pressed). | [ OK ] Started /etc/rc.local Compatibility. | [ OK ] Started LSB: rng-tools (Debian variant). | [ OK ] Started User Login Management. | [ OK ] Finished Permit User Sessions. | [ OK ] Started Serial Getty on ttyAMA0. | [ OK ] Reached target Login Prompts. | Starting User configuration dialog... | | Debian GNU/Linux 11 raspberrypi ttyAMA0 | | raspberrypi login: root (automatic login) | | Linux raspberrypi 5.4.83-v8+ #1 SMP PREEMPT Mon May 8 22:21:12 UTC 2023 aarch64 | | The programs included with the Debian GNU/Linux system are free software; | the exact distribution terms for each program are described in the | individual files in /usr/share/doc/*/copyright. | | Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent | permitted by applicable law. | [ OK ] Finished Wait Until Kernel Time Synchronized. | [FAILED] Failed to start Configure …ooth Modems connected by UART. | See 'systemctl status hciuart.service' for details. | [ OK ] Started DHCP Client Daemon. | [ OK ] Finished Rotate log files. | [ OK ] Created slice User Slice of UID 0. | Starting OpenBSD Secure Shell server... | Starting User Runtime Directory /run/user/0... | [ OK ] Finished User Runtime Directory /run/user/0. | Starting User Manager for UID 0... | [ OK ] Finished Daily man-db regeneration. | [ OK ] Started OpenBSD Secure Shell server. | [ OK ] Finished Turn on SSH if /boot/ssh is present. | [ OK ] Started User Manager for UID 0. | [ OK ] Started Session 1 of user root. | fatal: [172.16.238.10]: FAILED! => {"changed": false, "elapsed": 601, "msg": "timed out waiting for ping module test success: Invalid/incorrect password: Please note that SSH may not work until a valid user has been set up.\n\nSee http://rptl.io/newuser for details.\nPermission denied, please try again."} | | PLAY RECAP ***** | 172.16.238.10 : ok=0 changed=0 unreachable=0 failed=1 skipped=0 rescued=0 ignored=0
| exited with code 2

AndreCox commented 1 year ago

Hello @7abc39bd7efb38 Thank you for brining this to my attention, I belive pi-ci which I use to create the Pi Emulator has been updated which means that in new raspbian builds they require a password to be created manually. As a quick fix I will try to update the docker-compose file to use an older version of pi-ci

AndreCox commented 1 year ago

So I was able to recreate this issue, I shall work to resolve this

AndreCox commented 1 year ago

I just pushed a change that should fix your issue, however I'll leave this issue open incase someone wants to modify the code to support the latest raspbian os

AndreCox / PIBaker

Out of the box, Ansible Fails With Invalid Password #3